builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1463201312.87 results: success (0) buildid: 20160513203440 builduid: 63929ea087254c649f6055527b933433 revision: 5a396ec2aeefb4db7298f2406f5132390eada6a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:32.874638) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:32.875063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:32.875335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:32.921214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:32.921484) ========= 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=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 21:48: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-05-13 21:48:33 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.401860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.339265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.339560) ========= 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=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.389395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.389706) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a396ec2aeefb4db7298f2406f5132390eada6a7 --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 5a396ec2aeefb4db7298f2406f5132390eada6a7 --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=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 21:48:33,639 truncating revision to first 12 chars 2016-05-13 21:48:33,639 Setting DEBUG logging. 2016-05-13 21:48:33,639 attempt 1/10 2016-05-13 21:48:33,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a396ec2aeef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 21:48:33,876 unpacking tar archive at: fx-team-5a396ec2aeef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.944353) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.944668) ========= script_repo_revision: 5a396ec2aeefb4db7298f2406f5132390eada6a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.945061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.945320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 21:48:33.953963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-13 21:48:33.954237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:48:34 INFO - MultiFileLogger online at 20160513 21:48:34 in /builds/slave/test 21:48:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:48:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:48:34 INFO - {'append_to_log': False, 21:48:34 INFO - 'base_work_dir': '/builds/slave/test', 21:48:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:48:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:48:34 INFO - 'branch': 'Fx-Team-Non-PGO', 21:48:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:48:34 INFO - 'config_files': ('talos/linux_config.py',), 21:48:34 INFO - 'default_actions': ('clobber', 21:48:34 INFO - 'read-buildbot-config', 21:48:34 INFO - 'download-and-extract', 21:48:34 INFO - 'populate-webroot', 21:48:34 INFO - 'create-virtualenv', 21:48:34 INFO - 'install', 21:48:34 INFO - 'run-tests'), 21:48:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:48:34 INFO - 'download_minidump_stackwalk': True, 21:48:34 INFO - 'download_symbols': 'ondemand', 21:48:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:48:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:48:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:48:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:48:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:48:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:48:34 INFO - 'installer_path': 'installer.exe', 21:48:34 INFO - 'log_level': 'info', 21:48:34 INFO - 'log_name': 'talos', 21:48:34 INFO - 'log_to_console': True, 21:48:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:48:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:48:34 INFO - 'opt_config_files': (), 21:48:34 INFO - 'pip_index': False, 21:48:34 INFO - 'sps_profile': False, 21:48:34 INFO - 'sps_profile_interval': 0, 21:48:34 INFO - 'suite': 'dromaeojs-e10s', 21:48:34 INFO - 'system_bits': '32', 21:48:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:48:34 INFO - 'title': 'talos-linux64-ix-043', 21:48:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:48:34 INFO - 'use_talos_json': True, 21:48:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:48:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:48:34 INFO - 'work_dir': 'build'} 21:48:34 INFO - ##### 21:48:34 INFO - ##### Running clobber step. 21:48:34 INFO - ##### 21:48:34 INFO - Running pre-action listener: _resource_record_pre_action 21:48:34 INFO - Running main action method: clobber 21:48:34 INFO - rmtree: /builds/slave/test/build 21:48:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:48:34 INFO - Running post-action listener: _resource_record_post_action 21:48:34 INFO - ##### 21:48:34 INFO - ##### Finished clobber step (success) 21:48:34 INFO - ##### 21:48:34 INFO - ##### 21:48:34 INFO - ##### Running read-buildbot-config step. 21:48:34 INFO - ##### 21:48:34 INFO - Running pre-action listener: _resource_record_pre_action 21:48:34 INFO - Running main action method: read_buildbot_config 21:48:34 INFO - Using buildbot properties: 21:48:34 INFO - { 21:48:34 INFO - "project": "", 21:48:34 INFO - "product": "firefox", 21:48:34 INFO - "script_repo_revision": "production", 21:48:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:48:34 INFO - "repository": "", 21:48:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:48:34 INFO - "buildid": "20160513203440", 21:48:34 INFO - "pgo_build": "False", 21:48:34 INFO - "basedir": "/builds/slave/test", 21:48:34 INFO - "buildnumber": 1291, 21:48:34 INFO - "slavename": "talos-linux64-ix-043", 21:48:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:48:34 INFO - "platform": "ubuntu64_hw", 21:48:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:48:34 INFO - "branch": "fx-team", 21:48:34 INFO - "repo_path": "integration/fx-team", 21:48:34 INFO - "revision": "5a396ec2aeefb4db7298f2406f5132390eada6a7", 21:48:34 INFO - "stage_platform": "linux64", 21:48:34 INFO - "builduid": "63929ea087254c649f6055527b933433", 21:48:34 INFO - "slavebuilddir": "test" 21:48:34 INFO - } 21:48:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:48:34 INFO - Running post-action listener: _resource_record_post_action 21:48:34 INFO - ##### 21:48:34 INFO - ##### Finished read-buildbot-config step (success) 21:48:34 INFO - ##### 21:48:34 INFO - ##### 21:48:34 INFO - ##### Running download-and-extract step. 21:48:34 INFO - ##### 21:48:34 INFO - Running pre-action listener: _resource_record_pre_action 21:48:34 INFO - Running main action method: download_and_extract 21:48:34 INFO - mkdir: /builds/slave/test/build/tests 21:48: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')]} 21:48:34 INFO - https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:48:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:48:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:48:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:36 INFO - Downloaded 1361 bytes. 21:48:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:48:36 INFO - Using the following test package requirements: 21:48:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:48:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:48:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'jsshell-linux-x86_64.zip'], 21:48:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:48:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:48:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:48:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:48:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:48:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:48:36 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')]} 21:48:36 INFO - https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:37 INFO - Downloaded 22447326 bytes. 21:48:37 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'] 21:48:37 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 21:48:39 INFO - Return code: 0 21:48:39 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 21:48:39 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')]} 21:48:39 INFO - https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:41 INFO - Downloaded 22447326 bytes. 21:48:41 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'] 21:48:41 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 21:48:43 INFO - Return code: 0 21:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:43 INFO - https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:44 INFO - Downloaded 10840194 bytes. 21:48:44 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'] 21:48:44 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 21:48:44 INFO - Return code: 0 21:48: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')]} 21:48:44 INFO - https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O2hlyNdERte4lRHSrRl7rg/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 21:48:46 INFO - Downloaded 54727472 bytes. 21:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:48:46 INFO - mkdir: /builds/slave/test/properties 21:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 21:48:46 INFO - Contents: 21:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:48:47 INFO - Running post-action listener: _resource_record_post_action 21:48:47 INFO - Running post-action listener: set_extra_try_arguments 21:48:47 INFO - ##### 21:48:47 INFO - ##### Finished download-and-extract step (success) 21:48:47 INFO - ##### 21:48:47 INFO - ##### 21:48:47 INFO - ##### Running populate-webroot step. 21:48:47 INFO - ##### 21:48:47 INFO - Running pre-action listener: _resource_record_pre_action 21:48:47 INFO - Running main action method: populate_webroot 21:48:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:48:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:48:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:48:47 INFO - '--tppagecycles', 21:48:47 INFO - '7'], 21:48:47 INFO - 'tests': ['tsvgm']}}, 21:48:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:48:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:48:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:48:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:48:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['damp', 'tps']}, 21:48:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'tests': ['damp', 'tps']}, 21:48:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['dromaeo_dom']}, 21:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:48:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'other-e10s': {'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['a11yr', 21:48:47 INFO - 'ts_paint', 21:48:47 INFO - 'tpaint', 21:48:47 INFO - 'sessionrestore', 21:48:47 INFO - 'sessionrestore_no_auto_restore', 21:48:47 INFO - 'tabpaint']}, 21:48:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['tsvgx', 21:48:47 INFO - 'tsvgr_opacity', 21:48:47 INFO - 'tart', 21:48:47 INFO - 'tscrollx', 21:48:47 INFO - 'cart']}, 21:48:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:48:47 INFO - 'tsvgr_opacity', 21:48:47 INFO - 'tart', 21:48:47 INFO - 'tscrollx', 21:48:47 INFO - 'cart']}, 21:48:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'talos_options': ['--disable-e10s'], 21:48:47 INFO - 'tests': ['tp5o']}, 21:48:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'tests': ['tp5o']}, 21:48:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'talos_options': ['--disable-e10s', 21:48:47 INFO - '--xperf_path', 21:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:47 INFO - 'tests': ['tp5n']}, 21:48:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:47 INFO - 'talos_options': ['--xperf_path', 21:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:47 INFO - 'tests': ['tp5n']}}, 21:48:47 INFO - 'talos.zip': {'path': '', 21:48:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:48:47 INFO - Running post-action listener: _resource_record_post_action 21:48:47 INFO - ##### 21:48:47 INFO - ##### Finished populate-webroot step (success) 21:48:47 INFO - ##### 21:48:47 INFO - ##### 21:48:47 INFO - ##### Running create-virtualenv step. 21:48:47 INFO - ##### 21:48:47 INFO - Running pre-action listener: _resource_record_pre_action 21:48:47 INFO - Running main action method: create_virtualenv 21:48:47 INFO - Creating virtualenv /builds/slave/test/build/venv 21:48:47 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 21:48:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:48:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:48:47 INFO - Using real prefix '/usr' 21:48:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 21:48:49 INFO - Installing pip.................done. 21:48:49 INFO - Return code: 0 21:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:49 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:48:49 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 21:48:49 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 21:48:49 INFO - Using env: {'DISPLAY': ':0', 21:48:49 INFO - 'HOME': '/home/cltbld', 21:48:49 INFO - 'LANG': 'en_US.UTF-8', 21:48:49 INFO - 'LANGUAGE': 'en_US:en', 21:48:49 INFO - 'LOGNAME': 'cltbld', 21:48:49 INFO - 'MAIL': '/var/mail/cltbld', 21:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:49 INFO - 'MOZ_NO_REMOTE': '1', 21:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:49 INFO - 'NO_EM_RESTART': '1', 21:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:49 INFO - 'PWD': '/builds/slave/test', 21:48:49 INFO - 'SHELL': '/bin/bash', 21:48:49 INFO - 'SHLVL': '1', 21:48:49 INFO - 'TERM': 'linux', 21:48:49 INFO - 'TMOUT': '86400', 21:48:49 INFO - 'USER': 'cltbld', 21:48:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:49 INFO - '_': '/tools/buildbot/bin/python'} 21:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:50 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 21:48:50 INFO - Cleaning up... 21:48:50 INFO - Return code: 0 21:48:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:50 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:48:50 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 21:48:50 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 21:48:50 INFO - Using env: {'DISPLAY': ':0', 21:48:50 INFO - 'HOME': '/home/cltbld', 21:48:50 INFO - 'LANG': 'en_US.UTF-8', 21:48:50 INFO - 'LANGUAGE': 'en_US:en', 21:48:50 INFO - 'LOGNAME': 'cltbld', 21:48:50 INFO - 'MAIL': '/var/mail/cltbld', 21:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:50 INFO - 'MOZ_NO_REMOTE': '1', 21:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:50 INFO - 'NO_EM_RESTART': '1', 21:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:50 INFO - 'PWD': '/builds/slave/test', 21:48:50 INFO - 'SHELL': '/bin/bash', 21:48:50 INFO - 'SHLVL': '1', 21:48:50 INFO - 'TERM': 'linux', 21:48:50 INFO - 'TMOUT': '86400', 21:48:50 INFO - 'USER': 'cltbld', 21:48:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:50 INFO - '_': '/tools/buildbot/bin/python'} 21:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:50 INFO - Downloading/unpacking psutil>=3.1.1 21:48:50 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 21:48:50 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 21:48:50 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 21:48:50 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 21:48:50 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 21:48:50 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 21:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:52 INFO - Installing collected packages: psutil 21:48:52 INFO - Running setup.py install for psutil 21:48:52 INFO - building 'psutil._psutil_linux' extension 21:48:52 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 21:48:52 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 21:48:52 INFO - building 'psutil._psutil_posix' extension 21:48:52 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 21:48:52 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 21:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:52 INFO - Successfully installed psutil 21:48:52 INFO - Cleaning up... 21:48:52 INFO - Return code: 0 21:48:52 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 21:48:52 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')]} 21:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 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')]} 21:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:52 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:48:52 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 21:48:52 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 21:48:52 INFO - Using env: {'DISPLAY': ':0', 21:48:52 INFO - 'HOME': '/home/cltbld', 21:48:52 INFO - 'LANG': 'en_US.UTF-8', 21:48:52 INFO - 'LANGUAGE': 'en_US:en', 21:48:52 INFO - 'LOGNAME': 'cltbld', 21:48:52 INFO - 'MAIL': '/var/mail/cltbld', 21:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:52 INFO - 'MOZ_NO_REMOTE': '1', 21:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:52 INFO - 'NO_EM_RESTART': '1', 21:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:52 INFO - 'PWD': '/builds/slave/test', 21:48:52 INFO - 'SHELL': '/bin/bash', 21:48:52 INFO - 'SHLVL': '1', 21:48:52 INFO - 'TERM': 'linux', 21:48:52 INFO - 'TMOUT': '86400', 21:48:52 INFO - 'USER': 'cltbld', 21:48:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:52 INFO - '_': '/tools/buildbot/bin/python'} 21:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:53 INFO - Downloading/unpacking mozsystemmonitor==0.1 21:48:53 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 21:48:53 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 21:48:53 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 21:48:53 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 21:48:53 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 21:48:53 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 21:48:54 INFO - Downloading mozsystemmonitor-0.1.tar.gz 21:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 21:48:55 INFO - Installing collected packages: mozsystemmonitor 21:48:55 INFO - Running setup.py install for mozsystemmonitor 21:48:55 INFO - Successfully installed mozsystemmonitor 21:48:55 INFO - Cleaning up... 21:48:55 INFO - Return code: 0 21:48:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:48: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')]} 21:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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', '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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:48: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 blobuploader==1.2.4 21:48:55 INFO - Using env: {'DISPLAY': ':0', 21:48:55 INFO - 'HOME': '/home/cltbld', 21:48:55 INFO - 'LANG': 'en_US.UTF-8', 21:48:55 INFO - 'LANGUAGE': 'en_US:en', 21:48:55 INFO - 'LOGNAME': 'cltbld', 21:48:55 INFO - 'MAIL': '/var/mail/cltbld', 21:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:55 INFO - 'MOZ_NO_REMOTE': '1', 21:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:55 INFO - 'NO_EM_RESTART': '1', 21:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:55 INFO - 'PWD': '/builds/slave/test', 21:48:55 INFO - 'SHELL': '/bin/bash', 21:48:55 INFO - 'SHLVL': '1', 21:48:55 INFO - 'TERM': 'linux', 21:48:55 INFO - 'TMOUT': '86400', 21:48:55 INFO - 'USER': 'cltbld', 21:48:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:55 INFO - '_': '/tools/buildbot/bin/python'} 21:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:55 INFO - Downloading/unpacking blobuploader==1.2.4 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:57 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:48:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:57 INFO - Downloading docopt-0.6.1.tar.gz 21:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:48:58 INFO - Installing collected packages: blobuploader, requests, docopt 21:48:58 INFO - Running setup.py install for blobuploader 21:48:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:48:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:48:58 INFO - Running setup.py install for requests 21:48:58 INFO - Running setup.py install for docopt 21:48:58 INFO - Successfully installed blobuploader requests docopt 21:48:58 INFO - Cleaning up... 21:48:58 INFO - Return code: 0 21:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:58 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:48:58 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 21:48:58 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 21:48:58 INFO - Using env: {'DISPLAY': ':0', 21:48:58 INFO - 'HOME': '/home/cltbld', 21:48:58 INFO - 'LANG': 'en_US.UTF-8', 21:48:58 INFO - 'LANGUAGE': 'en_US:en', 21:48:58 INFO - 'LOGNAME': 'cltbld', 21:48:58 INFO - 'MAIL': '/var/mail/cltbld', 21:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:58 INFO - 'MOZ_NO_REMOTE': '1', 21:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:58 INFO - 'NO_EM_RESTART': '1', 21:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:58 INFO - 'PWD': '/builds/slave/test', 21:48:58 INFO - 'SHELL': '/bin/bash', 21:48:58 INFO - 'SHLVL': '1', 21:48:58 INFO - 'TERM': 'linux', 21:48:58 INFO - 'TMOUT': '86400', 21:48:58 INFO - 'USER': 'cltbld', 21:48:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:58 INFO - '_': '/tools/buildbot/bin/python'} 21:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:58 INFO - Running setup.py (path:/tmp/pip-fJQuDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:58 INFO - Running setup.py (path:/tmp/pip-hY3cz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:58 INFO - Running setup.py (path:/tmp/pip-3lYttB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:59 INFO - Running setup.py (path:/tmp/pip-YTIqz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:59 INFO - Running setup.py (path:/tmp/pip-kdku5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:59 INFO - Running setup.py (path:/tmp/pip-0fLzih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:59 INFO - Running setup.py (path:/tmp/pip-NBps60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:59 INFO - Running setup.py (path:/tmp/pip-PJwB10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:59 INFO - Running setup.py (path:/tmp/pip-Er5jc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:59 INFO - Running setup.py (path:/tmp/pip-mxSfJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:59 INFO - Running setup.py (path:/tmp/pip-2mC1YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:59 INFO - Running setup.py (path:/tmp/pip-euHmov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:59 INFO - Running setup.py (path:/tmp/pip-uuHSRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:59 INFO - Running setup.py (path:/tmp/pip-ssgGZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:59 INFO - Running setup.py (path:/tmp/pip-ruXSTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:59 INFO - Running setup.py (path:/tmp/pip-mfhVLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:59 INFO - Running setup.py (path:/tmp/pip-liWwyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:49:00 INFO - Running setup.py install for manifestparser 21:49:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Running setup.py install for mozcrash 21:49:00 INFO - Running setup.py install for mozdebug 21:49:00 INFO - Running setup.py install for mozdevice 21:49:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Running setup.py install for mozfile 21:49:00 INFO - Running setup.py install for mozhttpd 21:49:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Running setup.py install for mozinfo 21:49:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Running setup.py install for mozInstall 21:49:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:49:00 INFO - Running setup.py install for mozleak 21:49:00 INFO - Running setup.py install for mozlog 21:49:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Running setup.py install for moznetwork 21:49:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Running setup.py install for mozprocess 21:49:01 INFO - Running setup.py install for mozprofile 21:49:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Running setup.py install for mozrunner 21:49:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Running setup.py install for mozscreenshot 21:49:01 INFO - Running setup.py install for moztest 21:49:01 INFO - Running setup.py install for mozversion 21:49:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:49:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:49:01 INFO - Cleaning up... 21:49:01 INFO - Return code: 0 21:49:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:01 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:49:01 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 21:49:01 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 21:49:01 INFO - Using env: {'DISPLAY': ':0', 21:49:01 INFO - 'HOME': '/home/cltbld', 21:49:01 INFO - 'LANG': 'en_US.UTF-8', 21:49:01 INFO - 'LANGUAGE': 'en_US:en', 21:49:01 INFO - 'LOGNAME': 'cltbld', 21:49:01 INFO - 'MAIL': '/var/mail/cltbld', 21:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:01 INFO - 'MOZ_NO_REMOTE': '1', 21:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:01 INFO - 'NO_EM_RESTART': '1', 21:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:01 INFO - 'PWD': '/builds/slave/test', 21:49:01 INFO - 'SHELL': '/bin/bash', 21:49:01 INFO - 'SHLVL': '1', 21:49:01 INFO - 'TERM': 'linux', 21:49:01 INFO - 'TMOUT': '86400', 21:49:01 INFO - 'USER': 'cltbld', 21:49:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:01 INFO - '_': '/tools/buildbot/bin/python'} 21:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:02 INFO - Running setup.py (path:/tmp/pip-ZaPpil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:02 INFO - Running setup.py (path:/tmp/pip-uU0VDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:02 INFO - Running setup.py (path:/tmp/pip-ycGGd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:02 INFO - Running setup.py (path:/tmp/pip-OWKJRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:02 INFO - Running setup.py (path:/tmp/pip-VbVY5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:02 INFO - Running setup.py (path:/tmp/pip-11_SVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:02 INFO - Running setup.py (path:/tmp/pip-jqtPnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:02 INFO - Running setup.py (path:/tmp/pip-uoeb5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:02 INFO - Running setup.py (path:/tmp/pip-TW42nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:02 INFO - Running setup.py (path:/tmp/pip-GRogj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:02 INFO - Running setup.py (path:/tmp/pip-Xjlzzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:02 INFO - Running setup.py (path:/tmp/pip-vz9Jzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:02 INFO - Running setup.py (path:/tmp/pip-QMSBhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:02 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)) 21:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:02 INFO - Running setup.py (path:/tmp/pip-JnPKQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:03 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)) 21:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:03 INFO - Running setup.py (path:/tmp/pip-o6FSTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:03 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)) 21:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:03 INFO - Running setup.py (path:/tmp/pip-4JM4Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:03 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)) 21:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:03 INFO - Running setup.py (path:/tmp/pip-FVidZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:03 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)) 21:49:03 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)) 21:49:03 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)) 21:49:03 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)) 21:49:03 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)) 21:49:03 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)) 21:49:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:05 INFO - Downloading blessings-1.6.tar.gz 21:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:49:05 INFO - Installing collected packages: blessings 21:49:05 INFO - Running setup.py install for blessings 21:49:05 INFO - Successfully installed blessings 21:49:05 INFO - Cleaning up... 21:49:05 INFO - Return code: 0 21:49:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:05 INFO - Reading from file tmpfile_stdout 21:49:05 INFO - Current package versions: 21:49:05 INFO - argparse == 1.2.1 21:49:05 INFO - blessings == 1.6 21:49:05 INFO - blobuploader == 1.2.4 21:49:05 INFO - docopt == 0.6.1 21:49:05 INFO - manifestparser == 1.1 21:49:05 INFO - mozInstall == 1.12 21:49:05 INFO - mozcrash == 0.17 21:49:05 INFO - mozdebug == 0.1 21:49:05 INFO - mozdevice == 0.48 21:49:05 INFO - mozfile == 1.2 21:49:05 INFO - mozhttpd == 0.7 21:49:05 INFO - mozinfo == 0.9 21:49:05 INFO - mozleak == 0.1 21:49:05 INFO - mozlog == 3.2 21:49:05 INFO - moznetwork == 0.27 21:49:05 INFO - mozprocess == 0.22 21:49:05 INFO - mozprofile == 0.28 21:49:05 INFO - mozrunner == 6.11 21:49:05 INFO - mozscreenshot == 0.1 21:49:05 INFO - mozsystemmonitor == 0.1 21:49:05 INFO - moztest == 0.7 21:49:05 INFO - mozversion == 1.4 21:49:05 INFO - psutil == 3.1.1 21:49:05 INFO - requests == 1.2.3 21:49:05 INFO - wsgiref == 0.1.2 21:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:05 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')]} 21:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:05 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')]} 21:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:05 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:49:05 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 21:49:05 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 21:49:05 INFO - Using env: {'DISPLAY': ':0', 21:49:05 INFO - 'HOME': '/home/cltbld', 21:49:05 INFO - 'LANG': 'en_US.UTF-8', 21:49:05 INFO - 'LANGUAGE': 'en_US:en', 21:49:05 INFO - 'LOGNAME': 'cltbld', 21:49:05 INFO - 'MAIL': '/var/mail/cltbld', 21:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:05 INFO - 'MOZ_NO_REMOTE': '1', 21:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:05 INFO - 'NO_EM_RESTART': '1', 21:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:05 INFO - 'PWD': '/builds/slave/test', 21:49:05 INFO - 'SHELL': '/bin/bash', 21:49:05 INFO - 'SHLVL': '1', 21:49:05 INFO - 'TERM': 'linux', 21:49:05 INFO - 'TMOUT': '86400', 21:49:05 INFO - 'USER': 'cltbld', 21:49:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:05 INFO - '_': '/tools/buildbot/bin/python'} 21:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 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)) 21:49:05 INFO - Cleaning up... 21:49:05 INFO - Return code: 0 21:49:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:49:05 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')]} 21:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:05 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')]} 21:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:05 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:49:05 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 21:49:05 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 21:49:05 INFO - Using env: {'DISPLAY': ':0', 21:49:05 INFO - 'HOME': '/home/cltbld', 21:49:05 INFO - 'LANG': 'en_US.UTF-8', 21:49:05 INFO - 'LANGUAGE': 'en_US:en', 21:49:05 INFO - 'LOGNAME': 'cltbld', 21:49:05 INFO - 'MAIL': '/var/mail/cltbld', 21:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:05 INFO - 'MOZ_NO_REMOTE': '1', 21:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:05 INFO - 'NO_EM_RESTART': '1', 21:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:05 INFO - 'PWD': '/builds/slave/test', 21:49:05 INFO - 'SHELL': '/bin/bash', 21:49:05 INFO - 'SHLVL': '1', 21:49:05 INFO - 'TERM': 'linux', 21:49:05 INFO - 'TMOUT': '86400', 21:49:05 INFO - 'USER': 'cltbld', 21:49:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:05 INFO - '_': '/tools/buildbot/bin/python'} 21:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:06 INFO - Downloading/unpacking jsonschema 21:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:49:07 INFO - Downloading/unpacking functools32 (from jsonschema) 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:08 INFO - Downloading functools32-3.2.3-2.tar.gz 21:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:49:08 INFO - warning: no files found matching '*.txt' 21:49:08 INFO - no previously-included directories found matching 'build' 21:49:08 INFO - no previously-included directories found matching 'dist' 21:49:08 INFO - no previously-included directories found matching '.git*' 21:49:08 INFO - Installing collected packages: jsonschema, functools32 21:49:08 INFO - Running setup.py install for functools32 21:49:08 INFO - warning: no files found matching '*.txt' 21:49:08 INFO - no previously-included directories found matching 'build' 21:49:08 INFO - no previously-included directories found matching 'dist' 21:49:08 INFO - no previously-included directories found matching '.git*' 21:49:08 INFO - Successfully installed jsonschema functools32 21:49:08 INFO - Cleaning up... 21:49:08 INFO - Return code: 0 21:49:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:49:08 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')]} 21:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 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')]} 21:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 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 0x7faad7e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, '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': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', '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 21:49:08 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 21:49:08 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 21:49:08 INFO - Using env: {'DISPLAY': ':0', 21:49:08 INFO - 'HOME': '/home/cltbld', 21:49:08 INFO - 'LANG': 'en_US.UTF-8', 21:49:08 INFO - 'LANGUAGE': 'en_US:en', 21:49:08 INFO - 'LOGNAME': 'cltbld', 21:49:08 INFO - 'MAIL': '/var/mail/cltbld', 21:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:08 INFO - 'MOZ_NO_REMOTE': '1', 21:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:08 INFO - 'NO_EM_RESTART': '1', 21:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:08 INFO - 'PWD': '/builds/slave/test', 21:49:08 INFO - 'SHELL': '/bin/bash', 21:49:08 INFO - 'SHLVL': '1', 21:49:08 INFO - 'TERM': 'linux', 21:49:08 INFO - 'TMOUT': '86400', 21:49:08 INFO - 'USER': 'cltbld', 21:49:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:08 INFO - '_': '/tools/buildbot/bin/python'} 21:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:08 INFO - Downloading/unpacking flake8 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:49:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:49:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49: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 21:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:49:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:49:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:49:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:49:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:49:11 INFO - no previously-included directories found matching 'docs/_build' 21:49:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:49:11 INFO - Running setup.py install for pep8 21:49:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:49:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:49:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:49:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:49:11 INFO - no previously-included directories found matching 'docs/_build' 21:49:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:49:11 INFO - Cleaning up... 21:49:11 INFO - Return code: 0 21:49:11 INFO - Running post-action listener: _resource_record_post_action 21:49:11 INFO - Running post-action listener: _start_resource_monitoring 21:49:11 INFO - Starting resource monitoring. 21:49:11 INFO - ##### 21:49:11 INFO - ##### Finished create-virtualenv step (success) 21:49:11 INFO - ##### 21:49:11 INFO - ##### 21:49:11 INFO - ##### Running install step. 21:49:11 INFO - ##### 21:49:11 INFO - Running pre-action listener: _resource_record_pre_action 21:49:11 INFO - Running main action method: install 21:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:11 INFO - Reading from file tmpfile_stdout 21:49:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:49:11 INFO - Reading from file tmpfile_stdout 21:49:11 INFO - Output received: 21:49:11 INFO - Usage: mozinstall [options] installer 21:49:11 INFO - Options: 21:49:11 INFO - -h, --help show this help message and exit 21:49:11 INFO - -d DEST, --destination=DEST 21:49:11 INFO - Directory to install application into. [default: 21:49:11 INFO - "/builds/slave/test"] 21:49:11 INFO - --app=APP Application being installed. [default: firefox] 21:49:11 INFO - mkdir: /builds/slave/test/build/application 21:49:11 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'] 21:49:11 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 21:49:27 INFO - Reading from file tmpfile_stdout 21:49:27 INFO - Output received: 21:49:27 INFO - /builds/slave/test/build/application/firefox/firefox 21:49:27 INFO - Running post-action listener: _resource_record_post_action 21:49:27 INFO - ##### 21:49:27 INFO - ##### Finished install step (success) 21:49:27 INFO - ##### 21:49:27 INFO - ##### 21:49:27 INFO - ##### Running run-tests step. 21:49:27 INFO - ##### 21:49:27 INFO - Running pre-action listener: _resource_record_pre_action 21:49:27 INFO - Running main action method: run_tests 21:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:49:27 INFO - Python 2.7.3 21:49:27 INFO - Return code: 0 21:49:27 INFO - grabbing minidump binary from tooltool 21:49:27 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')]} 21:49:27 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 0x259eb20>, '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 0x259fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259feb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:49:27 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 21:49:27 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 21:49:27 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 21:49:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:49:27 INFO - Return code: 0 21:49:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:49:28 INFO - Return code: 0 21:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:49:28 INFO - Using env: {'DISPLAY': ':0', 21:49:28 INFO - 'HOME': '/home/cltbld', 21:49:28 INFO - 'LANG': 'en_US.UTF-8', 21:49:28 INFO - 'LANGUAGE': 'en_US:en', 21:49:28 INFO - 'LOGNAME': 'cltbld', 21:49:28 INFO - 'MAIL': '/var/mail/cltbld', 21:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:28 INFO - 'MOZ_NO_REMOTE': '1', 21:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:28 INFO - 'NO_EM_RESTART': '1', 21:49:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:28 INFO - 'PWD': '/builds/slave/test', 21:49:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:49:28 INFO - 'SHELL': '/bin/bash', 21:49:28 INFO - 'SHLVL': '1', 21:49:28 INFO - 'TERM': 'linux', 21:49:28 INFO - 'TMOUT': '86400', 21:49:28 INFO - 'USER': 'cltbld', 21:49:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463198398.110380-94581762', 21:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:28 INFO - '_': '/tools/buildbot/bin/python'} 21:49:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:49:28 INFO - mozversion application_buildid: 20160513203440 21:49:28 INFO - mozversion application_changeset: 5a396ec2aeefb4db7298f2406f5132390eada6a7 21:49:28 INFO - mozversion application_display_name: Nightly 21:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:49:28 INFO - mozversion application_name: Firefox 21:49:28 INFO - mozversion application_remotingname: firefox 21:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:49:28 INFO - mozversion application_vendor: Mozilla 21:49:28 INFO - mozversion application_version: 49.0a1 21:49:28 INFO - mozversion platform_buildid: 20160513203440 21:49:28 INFO - mozversion platform_changeset: 5a396ec2aeefb4db7298f2406f5132390eada6a7 21:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:49:28 INFO - mozversion platform_version: 49.0a1 21:49:28 INFO - using testdate: 1463201368 21:49:28 INFO - actual date: 1463201368 21:49:28 INFO - starting webserver on 'localhost:51165' 21:49:28 INFO - SUITE-START | Running 2 tests 21:49:28 INFO - TEST-START | dromaeo_css 21:49:28 INFO - operating with platform_type : linux_ 21:49:28 INFO - Initialising browser for dromaeo_css test... 21:49:28 INFO - TEST-INFO | started process 1039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxYZLKG/profile http://localhost:51165/getInfo.html) 21:49:32 INFO - PROCESS | 1039 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 21:49:32 INFO - PROCESS | 1039 | 21:49:32 INFO - PROCESS | 1039 | (process:1117): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:49:33 INFO - PROCESS | 1039 | __metrics Screen width/height:1600/1200 21:49:33 INFO - PROCESS | 1039 | colorDepth:24 21:49:33 INFO - PROCESS | 1039 | Browser inner width/height: 1024/697 21:49:33 INFO - PROCESS | 1039 | __metrics 21:49:34 ERROR - PROCESS | 1039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 21:49:35 INFO - TEST-INFO | 1039: exit 0 21:49:35 INFO - Browser initialized. 21:49:35 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:35 INFO - TEST-INFO | started process 1169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxYZLKG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:37 INFO - PROCESS | 1169 | 21:49:37 INFO - PROCESS | 1169 | (process:1298): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:49:47 INFO - PROCESS | 1169 | RSS: Main: 164528128 21:49:47 INFO - PROCESS | 1169 | 21:50:36 INFO - PROCESS | 1169 | 1463201436989 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] 21:52:49 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51165/tests/dromaeo/cssquery-ext.html) 21:52:50 INFO - PROCESS | 1169 | RSS: Main: 167661568 21:52:50 INFO - PROCESS | 1169 | 21:55:52 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-ext.html (next: http://localhost:51165/tests/dromaeo/cssquery-jquery.html) 21:55:52 INFO - PROCESS | 1169 | RSS: Main: 167354368 21:55:52 INFO - PROCESS | 1169 | 21:58:54 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51165/tests/dromaeo/cssquery-mootools.html) 21:58:55 INFO - PROCESS | 1169 | RSS: Main: 168194048 21:58:55 INFO - PROCESS | 1169 | 22:01:57 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51165/tests/dromaeo/cssquery-prototype.html) 22:01:58 INFO - PROCESS | 1169 | RSS: Main: 166137856 22:01:58 INFO - PROCESS | 1169 | 22:05:00 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51165/tests/dromaeo/cssquery-yui.html) 22:05:01 INFO - PROCESS | 1169 | RSS: Main: 166907904 22:05:01 INFO - PROCESS | 1169 | 22:08:03 INFO - PROCESS | 1169 | Cycle 1(1): loaded http://localhost:51165/tests/dromaeo/cssquery-yui.html (next: http://localhost:51165/tests/dromaeo/cssquery-dojo.html) 22:08:04 INFO - PROCESS | 1169 | RSS: Main: 168861696 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | __start_tp_report 22:08:04 INFO - PROCESS | 1169 | _x_x_mozilla_page_load 22:08:04 INFO - PROCESS | 1169 | _x_x_mozilla_page_load_details 22:08:04 INFO - PROCESS | 1169 | |i|pagename|runs| 22:08:04 INFO - PROCESS | 1169 | |0;dojo.html;2682.10149599884;2729.617853500509;2750.161200833746;2790.330320723027;2794.3014246438393;4793.592544633706;4846.273059041146;4859.975700121498;4898.314236006961;4899.461059283476;4776.593989510887;4853.854384368466;4862.659613827033;4870.4885986971385;4892.070506603752;4451.844185453501;4484.977575112136;4599.816007359702;4605.631549476034;4611.93082103767;534.1932417776586;4390;4450.844220452284;4549.886252843688;4553.4991150973365;4478;4512.2329204035395;4513.684042117053;4520.412346394981;4532.210425480946;4424;4541.750203738793;4547.204239258117;4552;4585.656075794329;4424.646028317727;4451.732896026248;4457.8439754608435;4487.259602165639;4492.865214043584;4711.411073615798;4731.124741922756;4748.57262846342;4754.402409109943;4805.519448055166;5119.283300337956;5200.8959820803375;5207.947920520822;5208;5275.208718692188;5327.041132596131;5358.517733404013;5360.383555891083;5370.355557333106;5391.919121213185;4949.703017818906;4959.851204463872;4963.776630051656;4974.129527332775;5008.9499105008845;5189.455107213764;5385.407605163429;5396.271503346998;5419.674819510842;5454.045542030129;5186.688798672092;5225.346831646044;5226.163813789775;5232.529072383504;5248.7900483980975;5329;5332.733363331896;5336.279602253724;5349.652272602269;5387.784488620489;5050.141475949097;5174.560162386239;5208.8958220835375;5215.29593504872;5229.764660590283;4991.625628077909;5152.433232344439;5172.5603323717905;5210.374755029421;5220.112580861262;4418.513963464016;4428.756418396954;4431.423914891108;4438.622717069021;4473.4408198975125;3781.2248489059675;3839.9424008639894;3866.284737323604;3887.047673319998;3902.024493876531;4612.97693511537;4618.607418369476;4620.676552641283;4632.073585282957;4649.04694537619;5112.8721781955;5328;5374.274472946102;5380.354357477049;5415;4555.2711566149255;4583.564561366731;4586.380838586815;4590.793414296365;4597.103564804898;4747.192977193886;4785.736784476887;4786.353842231324;4792.760361981887;4802.927956080662;4788.329633851194;4859.125357435554;5004.049230646311;5014.774335155;5031.169856973558;5213.973930130325;5231.843044708665;5255.684658920477;5264.921026184534;5312.946870531246;4895.4859739728245;4923;4927.581155601814;4931.3835770528685;4973.378327709036;5069.6197785167;5157.200633901752;5170.793168273377;5183.637145399785;5194.97402512985;5286.524212820865;5311.521963023347;5312.229726689531;5319.654222475527;5343.332083489564;5103.336566246364;5106.259592359162;5108.693478391308;5110.207917772751;5160.793568257378;4873.317735517101;5045.11710450677;5104;5109.437961824122;5112.565431938327;4789.066132104206;5026.623003274842;5030.798768049383;5073.365829271341;5123.666961647481;5243.161094224905;5254.238135470412;5254.527092561688;5266.762995665128;5308.442613525524;4839.588634965927;5003.4246061701915;5017.422996355466;5149.794008239778;5160.819371321985 22:08:04 INFO - PROCESS | 1169 | |1;ext.html;552.8313864271398;603.5624172474957;603.9607425517338;617.8609812792121;639.8592309691866;37202;41729.79135104328;41774.79112604433;41778.164436711246;41886.58113418865;42790.57209427905;43156;43536.12927741443;43573.78213108938;43628.781856090754;7877.960610196941;8051.194880511961;8056.113827479002;8059.919400805976;8080.797980050487;8009.67961281548;8087.595620218995;8093.39299552533;8102.959485202566;8113.797155071141;8092.069412017605;8107.594620268992;8113.675452981874;8118;8139.552324622144;8046.316063134641;8059.717909873156;8063.395245356622;8077.071136819282;8083.676652933876;7851.254130857559;7942.126366099725;7954.880676789853;7992.280694737501;7992.720254791055;32032.83983580067;39337.21325573473;39679.8016009921;39799.20401591981;39848;3178.8887388941507;3329.8002119872885;3422.9828850855833;3892.6691231245377;3983.4821473208585;28305.15084547467;28361.716382836115;28842.134735957956;30252.697473025208;30303.393932121235;3180.1413618323154;3192.776505644606;3234.5633339499336;3236.271838836243;3247.0745837436452;242415;243585;243586;244144.77927610427;246160;33660.663393366245;34206.82896585551;34310.65689343074;34354.656453435644;34410;34439.82780086083;36120.458193127124;36187.81906090453;36216.81891590525;36269.45595816065;14290.928545357207;14491.058081224686;14538.200398978157;14538.927305363406;14568.781468277984;11757.176997610257;12021.338826364634;12073;12084.939575302067;12104.334261615695;8404.495730256203;8430.915690843136;8461.23848853606;8517;8535.743927682179;3213.903582892517;3245.9126192725703;3261.6901394367496;3272.836358182129;3278.885239016623;862.905080441151;899.3128174484561;919.2921450483224;923.169147767015;951.9000504946881;28612.856935715605;28993.56509652357;29028.7097129026;29094.709052909624;29409.411811763646;902.3863772634671;923.3997901364168;963.6482683820356;985.9992108010375;993.4982833668951;15180.396527510567;15442.45951391696;15570.766438503431;15598.688026239639;15797;401466;405069;405479;407243;408672;52361;53159;53164;53293;53299.20051199235;1236.71555542224;1254.9458454897929;1263.5135472842837;1289.1942535915052;1300.570811632178;27078.864605676845;28557.571636425055;28971.7102828969;31417;32058.35883282368;42770.144597108505;42999;43185;43185.13629727325;43239.35140972951;386154;392202;396248;396961;398124;39972.80013599913;40319.79840100781;40553.391699123946;40715.592844072366;41376.793116035435;44434.33348499711;44703;44971.77514112408;45817.312740308254;46030.53969460396;37749.245015100096;38173;38635.61364386432;38880.41679374755;39754;37465.85637455856;38234.23531529409;38260.426093609174;38830.2233955325;39241.6075839238;35189.29621407609;37701.81149094237;38339.80830095831;39417.2116557673;42171.7891410541;32545.021042039243;33436.33127337391;33899.83050084734;34456;34502.65497344994;26372.208833735018;26555.601665975413;26877.865610671823;27010.459790804467;27462.725372746016 22:08:04 INFO - PROCESS | 1169 | |2;jquery.html;369.67099281639344;376.90388950817544;379.747467933824;389.63569062926183;390.859290655364;16333.18334083297;16863.32546698132;17819.910900445513;17837.732434013502;18478.2608695652;10703.464826758669;11116.555337786478;11256.268342557729;11281.943590282057;11309.773804523926;3514.4728290756334;4576.3296396815085;4646.5121162278065;4767.11808315461;4782.378290822188;5199.974000129994;5465.398806131322;5518.834434966937;5571.8607034824045;5597.916031259534;4975.3283306753665;5522.22688823563;5525.392206857243;5545.528630066449;5551.916721249164;5238.842834714946;5304.6286759926825;5326.840194794182;5340.305760251143;5361.490658387466;5035.496450354972;5350.652207606493;5367.677939323653;5386.946130538723;5395.082835917864;12415.75168496634;12623.242605443702;12873.67815804603;12919.870801291961;12928;1885.3118611706766;1938.37002974034;2009.849261305408;2025.8379329653592;2543.7074736405366;8611.397202195849;8911.509866957314;9180.908190918071;9235.630574777;9556.90443095567;1805.900675462849;1807.1957978699484;1939.8157175068345;2002.4192984034612;2006.0772044859382;70376;72134.63932680304;72225.63887180583;72977.99999999948;73587.26412735911;10230.488475576192;10255.641052563275;10307.896921030844;10401.895981040092;10427.895721042692;14011.08927919682;14038.71922561543;14087.225202613954;14095.224762637949;14151.221682807338;7349.926500735031;7606.581638009852;7623.428242881806;7670.348020418327;7744.148143704188;6943.166819981533;7078.292170782984;7347.669354879044;7501.962490187514;7511.887321690179;4362.912741745147;4463.107378524243;4474.753888536096;4489.775511224491;4584.220682483919;1657.8176400595926;1755.1312100510074;1854.332440321483;1864.5991111911005;1881.3697411367345;828.3828547731857;903.5888670654837;986.8865080515833;991.3457118302031;998.4608311511703;16235.350585976428;17055.061971591433;17220.569485762706;17413.390531331344;17527.82472175262;828.1759649149135;833.4582521361043;875.9781005474787;880.4673172730406;924.4176169013479;8679.26226270774;9641.469719165372;9711.902880971242;9803.901960980442;9867.654632087842;318701;324789;325050;402517;407834;82165;86287.56856215805;86571;87895.1210487887;87935.56032219798;944.8204841080172;958.5399008475971;958.5830163878595;970.3401686852867;992.2211064314479;15443;15771.763423548886;15917;16188.757168642715;16424;37042;37685.2462950734;37896.81051594725;38144.42783358196;38358.6164138355;50604;52665.7366713164;54315.18527222174;54500.72749636226;55094.44905551054;7723.1118421380015;7804.492707973964;7835.49069310493;7960.442769006114;7966.402519810921;11267.774644507228;11893.524259029888;12081.516739330329;12280.324582148067;12329.691757706129;10605.575776968835;10676.83984740214;10731.731706707395;10785.514651840529;10864.293820901616;9836.3606365586;9841.507924603884;10176.949115254376;10443.425611591436;11013.394263315595;10635.840462392916;11011.119110470983;11069.335839849635;11073.446327683745;11284.830727538929;7890.723824666339;7923;7924.524528528307;8015.238552337519;8040.437169398086;9767.706968790948;10669.786604268027;10865.402402867918;10880.782384352427;10931.18016148776 22:08:04 INFO - PROCESS | 1169 | |3;mootools.html;1481.4296495849098;1516.8710659593935;1659.178706540262;1767.9381221657245;1805.1786437171088;6897.758578449755;7755.612219389036;7795.493292935969;8279.172082791718;8326.417150799454;7830.9216907830905;8086.636101375438;8096.433249672526;8113.797155071112;8144.1448647892;2256.4133325335406;2287.0508738873345;2290.564792689392;2295.173737454515;2300.4133945843787;2227.354067320475;2243.540074284768;2288.8168946484325;2297.104129389531;2305.43516838374;2242.237639202671;2244.820414366855;2249.527599204161;2295.7130358705163;2296.5062511560013;2243.113969981848;2251.538434620899;2294.9426264343356;2295.6326987681973;2302.2057390200353;2244.5847518209184;2266.161520237523;2267.648514480242;2268.9886550567307;2272.45461089339;8128.268455839003;8187.304079153279;8189.426740128193;8194.180581941817;8207.794805129919;4791.137595232856;4940.184869496528;4949.084419382426;4951.90096198074;4958.2562615607585;2850.144956513038;2880.3375223698667;3056.8777248910237;3076.8769249230004;3076.9076927692204;908.8866138979763;932.8274269260208;961.4615815143542;970.5875003123645;983.1593987140963;11005.394703291317;11021.118310535137;11076.889231107747;11102.55589776408;11131.777364452666;4397.604215620546;4459.3979812724865;4525.185466616041;4548.385967894358;4568.428946381702;9578.329516933887;9654.517274136266;9656.806863862683;9662.468564229035;9687.70936871895;4814.277858321279;4838.032393521239;4852.927206091911;4856.78144483492;4864.270359446112;3832.904177395532;4148.377743338463;4170.9582904171175;4378.124375124988;4537.705049171794;3762;3844;3926.1755031443718;3944.5069366329208;4058.1477889642915;1230.8276841242234;1239.8388209532702;1241.6895776055985;1246.401727170963;1254.4319600499375;760.7717684694569;918.4397517514311;929.9070092990647;929.9070092990647;930.186087173723;5470.316210473691;5507.944920550824;5564.944350556523;5611.3266408031295;5693.572982026365;879.8548239540404;913.1142791492242;913.1142791492242;924.9630014799467;928.4986107501874;3530.3998320285614;3620.6741393274206;3632.72754543405;3637.672609465161;3655.3785856403942;9842.753931151636;9976.45129517869;10001.749956251006;10143.847842282372;10204.285700001077;9964;10048.79902401948;10077.445740484198;10082.747931301776;10105.949470252748;7571.3942884569105;7600.2779735925;7754.495957762728;7766.301032907066;7786.454948153688;5328.6802791832615;5336.7598458068705;5388.595855310789;5557.944420555743;5629.155626656035;8993.955030224806;9049.366544342096;9183.724488265363;9188.586513607037;9207.263418926605;9142.085791420805;9293.25653947669;9341.252699783865;9411.341206115507;9439.52802359893;6196.287426945959;6666.2333831609985;6845.247022827584;7048.224695283412;7098.964505177441;7863.685452582062;7879.054513458422;7890.881636775338;7929.088154862265;7957.244061814118;6929.618870962146;6997.790066298019;7064.823379415556;7146.821329466805;7168.462365322517;7028.613426261605;7065.116860392451;7092.574445533284;7110.43116550685;7256.7822965311125;6463.159789227559;6704;6715.56348837324;6726.260111387645;6837.3162683731225;4969.105560999054;5007.5993920487;5030.723310217827;5034.521720436553;5079.16193828029;4933.481984391731;4970.726610036338;4975.353204083591;4986.376702912136;5032.270320803536 22:08:04 INFO - PROCESS | 1169 | |4;prototype.html;302.9348690031643;306.90485949355696;309.71506214282874;315.97314228290594;317.2718610788241;5059.266406371074;5102.209157580576;5102.668326558775;5120.129577971745;5160.071187186314;5018.5985121190215;5027.773750181242;5048.510689346643;5068.797248110081;5073.416557095926;3737.570179429373;3862.613738626129;3964.6630036446936;3971.86098486553;3982.681385489154;3930.410438434229;3959.109200429909;3960.4257382679493;3967.642912137907;3973.9801300993454;3910.081130934228;3925.7840818754958;3954.228925359556;3957.2876882161345;3971.4439978403047;3797.5505798759646;3940.281205967873;3957.960420395788;3958.4062390641348;3962.48487696599;3471.4831746983486;3497.1956450016637;3498.5451891253974;3504.8247587620517;3505.2288496530978;4711.623070154379;4751.714897106184;4795.568398844121;4796.56830885222;4836.709797412166;4428.158649856549;4499.302608095751;4532.229520981441;4543.636509079266;4547.24970379887;5261.86845328866;5291.788328466857;5295.881647341056;5298.655587386807;5321.8935621287355;3809.733318667694;3814.275287695357;3816.122291872857;3820.732548721591;3830.176512049895;5446.183072539072;5546.251256080418;5555.694436805974;5563.221149039137;5588.91616625751;3885.8639947602264;3886.417037444406;3902.1610353774076;3917.05990562263;3920.9803950980063;3941.3890846918775;3972.741771784825;3974.8012599370495;3978.5424676162033;3985.1830374773103;4462.107578484316;4497.617702495259;4497.752623605667;4503;4506.062393170902;4971.6136254598;5268.236105764643;5272.657277276965;5319.255304257407;5322.201669749491;1316.5457917018614;1332.5935589645057;1344.9125806822722;1345.219772531929;1352.1008529327887;806.209914284005;826.3182874128868;842.8651415773447;849.2993280543576;856.7772379181457;4579.95420045802;4654.766486880979;4680.315086568832;4680.7191568506;4688.132695451352;5453.23654688344;5466.835994920079;5485.972570137204;5491.395946445888;5505.779768809283;4454.5990860822685;4689.648276379217;4693;4710.704556246991;4722.386089808303;2868.9815115634065;2893.4936386132345;2895.7683385329124;2900.550414685727;2905.5205891027745;5068;5099.821506247264;5101.066886540254;5106.463821298785;5124.078470573535;5449.237106805051;5483.862903427446;5607.943920560742;5608.915866262009;5627.539063475932;5093.668911520739;5117.437081920985;5144.948550514522;5161.380634323905;5176.938727560841;5447.891042179055;5454.3454785426;5463.153211252262;5477.45225477465;5492.423295553909;5108.821191258288;5285.788568457218;5304.859455217147;5358.892822143457;5372.785088596413;5102.43873173958;5115.746642072567;5131.79472821083;5132.8460146195675;5138.4604616514725;3773.9245215096093;3784.8296826642318;3788.5643151037984;3800.2969450651717;3808.714346424085;5257.4216836147225;5401.459854014567;5432.29380180574;5468;5536.861578460571;5257.4742525747115;5267.971830845228;5294.602904782079;5302.655327403706;5303.893922121459;5273.734303766992;5281.260623512788;5284.313039304866;5308.893822123458;5315.920261196008;4980.277859710394;5244.7639856207325;5262.289590905179;5262.500062494057;5271.367435907716;5125.846224613268;5193.68837869729;5318.228856815663;5329.893402131858;5330.360356757214;5178.97410512945;5197.298364720715;5197.402298735694;5206.219067139959;5214.817481388133 22:08:04 INFO - PROCESS | 1169 | |5;yui.html;686.9862602747944;729.3217307903651;768.6272158003371;809.2676128104064;848.1857416879795;11510.539578416863;13003.154794938335;13051.41268642911;13060.151090179132;13161.539346122887;12717.872821271785;12773.361331933389;12791.936040319808;12799.616011519645;12809.487620495192;704.5455681085697;869.504382501971;880.6521424037518;896.256107430834;898.4474548152872;884.6815146547237;886.2112719679491;887.0951629338072;888.0586578227068;889.5952341684518;935.1069728409353;940.0082912527281;941.0918463682546;942.0673533202115;943.9150476457118;928.6007016982695;929.8744669469603;932.7108596335158;937.3251259093441;938.1322276893914;683.9247682754893;687.8039758668806;688.1604442580044;688.1707542411382;688.7004153193377;11930.22453540517;12011.459484323226;12033.518659253707;12042.939785301105;12060.577879774166;12608.936955315256;12609.919363305044;12697.746045079046;12924.935375323157;13078.476860925552;9718.61125554977;9803.803923921552;9955;10103.595856165744;10154.847677284846;3313.701766840996;3333.183370074323;3383.7462190335823;3409.062507810347;3417.2140407706365;48343.51656483425;48535.51464485345;49082.754586227195;50357.49642503601;50574;10327.793444131226;10367.775136594264;10387.792244155075;10417.47912604382;10503.842442363371;19483.707744383562;19588.412347629594;19725.210991560463;19837.60324793496;20058;6859.519833611699;6922.653867306614;6950.235474097845;6982.650867456607;7008.929910700827;3818.770873747584;3819.427085937132;3834;3927.509061367329;3929.44987701722;2857.4713677969644;2953.394554116401;2962.6296712910885;2968.1095671298954;2981.359007813287;497.4701942431299;499.7501249375312;509.2997128947697;515.5098204126012;519.2574618295873;588.2059220052894;621.201755743867;629.7204121081713;633.3476519185247;634.7810005548079;8469.855341579578;8724.43291186071;8969.686060987835;8969.955150224338;9086.182243598108;495.7446914838861;505.6283631530822;510.10985829727366;510.67061745174897;553.5654511208681;3776.4712940188397;3814.6757525610633;3885.747426417274;3914.236723838881;3921.8039098044983;53086.46913530892;54697.1795423069;55015.44984550183;55125;55201;37042.44436333457;37058.44412333817;47252.29121563179;47901.76049119732;51357.743211283705;44677.32984005242;45420.54579454229;45450.545494545295;45620.315695264595;46491.070178596914;7567.432442566939;7771.239022050626;8031.076426210827;8044.2760151586635;8229.094799572162;31357.686423135478;31861.362772743953;32021.35957280888;32192.35615287728;32273.677263228008;39993.400098997954;40755.7962210187;40774.59225407708;41299.38050929298;41328.79335603303;9888.159506442033;9950.322975250754;10022.699319020441;10058.245631577514;10500.369977801356;10701.204471044344;10788.244822862323;10946.835797462885;11090.500927458123;11106.944465277622;9516.714498565054;9655.517224138624;10162.39025658463;10267.794644106927;10327.845082323922;9414.764630884283;9891.109800118023;9902.653407130716;10004.599816007569;10035.69892903214;9505.192058674813;9569.186619137452;9628.191312379962;9802.36284641496;10016.098551130433;7601.847963040819;7604.353629941517;7651.693932242871;7692.076950765944;7890.723824666109;7736.92263077362;7752.689892404241;7834.529928204326;7914.129445761077;7926.128125906261 22:08:04 INFO - PROCESS | 1169 | __end_tp_report 22:08:04 INFO - PROCESS | 1169 | __start_cc_report 22:08:04 INFO - PROCESS | 1169 | _x_x_mozilla_cycle_collect,387 22:08:04 INFO - PROCESS | 1169 | __end_cc_report 22:08:04 INFO - PROCESS | 1169 | __startTimestamp1463202484030__endTimestamp 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | ------- Summary: start ------- 22:08:04 INFO - PROCESS | 1169 | Number of tests: 6 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#0] dojo.html Cycles:165 Average:4831.50 Median:4974.13 stddev:614.80 (12.4%) stddev-sans-first:593.11 22:08:04 INFO - PROCESS | 1169 | Values: 2682.1 2729.6 2750.2 2790.3 2794.3 4793.6 4846.3 4860.0 4898.3 4899.5 4776.6 4853.9 4862.7 4870.5 4892.1 4451.8 4485.0 4599.8 4605.6 4611.9 534.2 4390.0 4450.8 4549.9 4553.5 4478.0 4512.2 4513.7 4520.4 4532.2 4424.0 4541.8 4547.2 4552.0 4585.7 4424.6 4451.7 4457.8 4487.3 4492.9 4711.4 4731.1 4748.6 4754.4 4805.5 5119.3 5200.9 5207.9 5208.0 5275.2 5327.0 5358.5 5360.4 5370.4 5391.9 4949.7 4959.9 4963.8 4974.1 5008.9 5189.5 5385.4 5396.3 5419.7 5454.0 5186.7 5225.3 5226.2 5232.5 5248.8 5329.0 5332.7 5336.3 5349.7 5387.8 5050.1 5174.6 5208.9 5215.3 5229.8 4991.6 5152.4 5172.6 5210.4 5220.1 4418.5 4428.8 4431.4 4438.6 4473.4 3781.2 3839.9 3866.3 3887.0 3902.0 4613.0 4618.6 4620.7 4632.1 4649.0 5112.9 5328.0 5374.3 5380.4 5415.0 4555.3 4583.6 4586.4 4590.8 4597.1 4747.2 4785.7 4786.4 4792.8 4802.9 4788.3 4859.1 5004.0 5014.8 5031.2 5214.0 5231.8 5255.7 5264.9 5312.9 4895.5 4923.0 4927.6 4931.4 4973.4 5069.6 5157.2 5170.8 5183.6 5195.0 5286.5 5311.5 5312.2 5319.7 5343.3 5103.3 5106.3 5108.7 5110.2 5160.8 4873.3 5045.1 5104.0 5109.4 5112.6 4789.1 5026.6 5030.8 5073.4 5123.7 5243.2 5254.2 5254.5 5266.8 5308.4 4839.6 5003.4 5017.4 5149.8 5160.8 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#1] ext.html Cycles:180 Average:49621.54 Median:39377.21 stddev:94004.06 (238.7%) stddev-sans-first:94195.58 22:08:04 INFO - PROCESS | 1169 | Values: 552.8 603.6 604.0 617.9 639.9 37202.0 41729.8 41774.8 41778.2 41886.6 42790.6 43156.0 43536.1 43573.8 43628.8 7878.0 8051.2 8056.1 8059.9 8080.8 8009.7 8087.6 8093.4 8103.0 8113.8 8092.1 8107.6 8113.7 8118.0 8139.6 8046.3 8059.7 8063.4 8077.1 8083.7 7851.3 7942.1 7954.9 7992.3 7992.7 32032.8 39337.2 39679.8 39799.2 39848.0 3178.9 3329.8 3423.0 3892.7 3983.5 28305.2 28361.7 28842.1 30252.7 30303.4 3180.1 3192.8 3234.6 3236.3 3247.1 242415.0 243585.0 243586.0 244144.8 246160.0 33660.7 34206.8 34310.7 34354.7 34410.0 34439.8 36120.5 36187.8 36216.8 36269.5 14290.9 14491.1 14538.2 14538.9 14568.8 11757.2 12021.3 12073.0 12084.9 12104.3 8404.5 8430.9 8461.2 8517.0 8535.7 3213.9 3245.9 3261.7 3272.8 3278.9 862.9 899.3 919.3 923.2 951.9 28612.9 28993.6 29028.7 29094.7 29409.4 902.4 923.4 963.6 986.0 993.5 15180.4 15442.5 15570.8 15598.7 15797.0 401466.0 405069.0 405479.0 407243.0 408672.0 52361.0 53159.0 53164.0 53293.0 53299.2 1236.7 1254.9 1263.5 1289.2 1300.6 27078.9 28557.6 28971.7 31417.0 32058.4 42770.1 42999.0 43185.0 43185.1 43239.4 386154.0 392202.0 396248.0 396961.0 398124.0 39972.8 40319.8 40553.4 40715.6 41376.8 44434.3 44703.0 44971.8 45817.3 46030.5 37749.2 38173.0 38635.6 38880.4 39754.0 37465.9 38234.2 38260.4 38830.2 39241.6 35189.3 37701.8 38339.8 39417.2 42171.8 32545.0 33436.3 33899.8 34456.0 34502.7 26372.2 26555.6 26877.9 27010.5 27462.7 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#2] jquery.html Cycles:180 Average:23544.46 Median:4482.26 stddev:59752.89 (1333.1%) stddev-sans-first:59895.18 22:08:04 INFO - PROCESS | 1169 | Values: 369.7 376.9 379.7 389.6 390.9 16333.2 16863.3 17819.9 17837.7 18478.3 10703.5 11116.6 11256.3 11281.9 11309.8 3514.5 4576.3 4646.5 4767.1 4782.4 5200.0 5465.4 5518.8 5571.9 5597.9 4975.3 5522.2 5525.4 5545.5 5551.9 5238.8 5304.6 5326.8 5340.3 5361.5 5035.5 5350.7 5367.7 5386.9 5395.1 12415.8 12623.2 12873.7 12919.9 12928.0 1885.3 1938.4 2009.8 2025.8 2543.7 8611.4 8911.5 9180.9 9235.6 9556.9 1805.9 1807.2 1939.8 2002.4 2006.1 70376.0 72134.6 72225.6 72978.0 73587.3 10230.5 10255.6 10307.9 10401.9 10427.9 14011.1 14038.7 14087.2 14095.2 14151.2 7349.9 7606.6 7623.4 7670.3 7744.1 6943.2 7078.3 7347.7 7502.0 7511.9 4362.9 4463.1 4474.8 4489.8 4584.2 1657.8 1755.1 1854.3 1864.6 1881.4 828.4 903.6 986.9 991.3 998.5 16235.4 17055.1 17220.6 17413.4 17527.8 828.2 833.5 876.0 880.5 924.4 8679.3 9641.5 9711.9 9803.9 9867.7 318701.0 324789.0 325050.0 402517.0 407834.0 82165.0 86287.6 86571.0 87895.1 87935.6 944.8 958.5 958.6 970.3 992.2 15443.0 15771.8 15917.0 16188.8 16424.0 37042.0 37685.2 37896.8 38144.4 38358.6 50604.0 52665.7 54315.2 54500.7 55094.4 7723.1 7804.5 7835.5 7960.4 7966.4 11267.8 11893.5 12081.5 12280.3 12329.7 10605.6 10676.8 10731.7 10785.5 10864.3 9836.4 9841.5 10176.9 10443.4 11013.4 10635.8 11011.1 11069.3 11073.4 11284.8 7890.7 7923.0 7924.5 8015.2 8040.4 9767.7 10669.8 10865.4 10880.8 10931.2 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#3] mootools.html Cycles:180 Average:5376.52 Median:5056.84 stddev:2986.84 (59.1%) stddev-sans-first:2980.87 22:08:04 INFO - PROCESS | 1169 | Values: 1481.4 1516.9 1659.2 1767.9 1805.2 6897.8 7755.6 7795.5 8279.2 8326.4 7830.9 8086.6 8096.4 8113.8 8144.1 2256.4 2287.1 2290.6 2295.2 2300.4 2227.4 2243.5 2288.8 2297.1 2305.4 2242.2 2244.8 2249.5 2295.7 2296.5 2243.1 2251.5 2294.9 2295.6 2302.2 2244.6 2266.2 2267.6 2269.0 2272.5 8128.3 8187.3 8189.4 8194.2 8207.8 4791.1 4940.2 4949.1 4951.9 4958.3 2850.1 2880.3 3056.9 3076.9 3076.9 908.9 932.8 961.5 970.6 983.2 11005.4 11021.1 11076.9 11102.6 11131.8 4397.6 4459.4 4525.2 4548.4 4568.4 9578.3 9654.5 9656.8 9662.5 9687.7 4814.3 4838.0 4852.9 4856.8 4864.3 3832.9 4148.4 4171.0 4378.1 4537.7 3762.0 3844.0 3926.2 3944.5 4058.1 1230.8 1239.8 1241.7 1246.4 1254.4 760.8 918.4 929.9 929.9 930.2 5470.3 5507.9 5564.9 5611.3 5693.6 879.9 913.1 913.1 925.0 928.5 3530.4 3620.7 3632.7 3637.7 3655.4 9842.8 9976.5 10001.7 10143.8 10204.3 9964.0 10048.8 10077.4 10082.7 10105.9 7571.4 7600.3 7754.5 7766.3 7786.5 5328.7 5336.8 5388.6 5557.9 5629.2 8994.0 9049.4 9183.7 9188.6 9207.3 9142.1 9293.3 9341.3 9411.3 9439.5 6196.3 6666.2 6845.2 7048.2 7099.0 7863.7 7879.1 7890.9 7929.1 7957.2 6929.6 6997.8 7064.8 7146.8 7168.5 7028.6 7065.1 7092.6 7110.4 7256.8 6463.2 6704.0 6715.6 6726.3 6837.3 4969.1 5007.6 5030.7 5034.5 5079.2 4933.5 4970.7 4975.4 4986.4 5032.3 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#4] prototype.html Cycles:180 Average:4394.77 Median:5063.63 stddev:1279.82 (25.3%) stddev-sans-first:1246.01 22:08:04 INFO - PROCESS | 1169 | Values: 302.9 306.9 309.7 316.0 317.3 5059.3 5102.2 5102.7 5120.1 5160.1 5018.6 5027.8 5048.5 5068.8 5073.4 3737.6 3862.6 3964.7 3971.9 3982.7 3930.4 3959.1 3960.4 3967.6 3974.0 3910.1 3925.8 3954.2 3957.3 3971.4 3797.6 3940.3 3958.0 3958.4 3962.5 3471.5 3497.2 3498.5 3504.8 3505.2 4711.6 4751.7 4795.6 4796.6 4836.7 4428.2 4499.3 4532.2 4543.6 4547.2 5261.9 5291.8 5295.9 5298.7 5321.9 3809.7 3814.3 3816.1 3820.7 3830.2 5446.2 5546.3 5555.7 5563.2 5588.9 3885.9 3886.4 3902.2 3917.1 3921.0 3941.4 3972.7 3974.8 3978.5 3985.2 4462.1 4497.6 4497.8 4503.0 4506.1 4971.6 5268.2 5272.7 5319.3 5322.2 1316.5 1332.6 1344.9 1345.2 1352.1 806.2 826.3 842.9 849.3 856.8 4580.0 4654.8 4680.3 4680.7 4688.1 5453.2 5466.8 5486.0 5491.4 5505.8 4454.6 4689.6 4693.0 4710.7 4722.4 2869.0 2893.5 2895.8 2900.6 2905.5 5068.0 5099.8 5101.1 5106.5 5124.1 5449.2 5483.9 5607.9 5608.9 5627.5 5093.7 5117.4 5144.9 5161.4 5176.9 5447.9 5454.3 5463.2 5477.5 5492.4 5108.8 5285.8 5304.9 5358.9 5372.8 5102.4 5115.7 5131.8 5132.8 5138.5 3773.9 3784.8 3788.6 3800.3 3808.7 5257.4 5401.5 5432.3 5468.0 5536.9 5257.5 5268.0 5294.6 5302.7 5303.9 5273.7 5281.3 5284.3 5308.9 5315.9 4980.3 5244.8 5262.3 5262.5 5271.4 5125.8 5193.7 5318.2 5329.9 5330.4 5179.0 5197.3 5197.4 5206.2 5214.8 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - PROCESS | 1169 | [#5] yui.html Cycles:180 Average:12983.25 Median:25428.62 stddev:15140.84 (59.5%) stddev-sans-first:15155.16 22:08:04 INFO - PROCESS | 1169 | Values: 687.0 729.3 768.6 809.3 848.2 11510.5 13003.2 13051.4 13060.2 13161.5 12717.9 12773.4 12791.9 12799.6 12809.5 704.5 869.5 880.7 896.3 898.4 884.7 886.2 887.1 888.1 889.6 935.1 940.0 941.1 942.1 943.9 928.6 929.9 932.7 937.3 938.1 683.9 687.8 688.2 688.2 688.7 11930.2 12011.5 12033.5 12042.9 12060.6 12608.9 12609.9 12697.7 12924.9 13078.5 9718.6 9803.8 9955.0 10103.6 10154.8 3313.7 3333.2 3383.7 3409.1 3417.2 48343.5 48535.5 49082.8 50357.5 50574.0 10327.8 10367.8 10387.8 10417.5 10503.8 19483.7 19588.4 19725.2 19837.6 20058.0 6859.5 6922.7 6950.2 6982.7 7008.9 3818.8 3819.4 3834.0 3927.5 3929.4 2857.5 2953.4 2962.6 2968.1 2981.4 497.5 499.8 509.3 515.5 519.3 588.2 621.2 629.7 633.3 634.8 8469.9 8724.4 8969.7 8970.0 9086.2 495.7 505.6 510.1 510.7 553.6 3776.5 3814.7 3885.7 3914.2 3921.8 53086.5 54697.2 55015.4 55125.0 55201.0 37042.4 37058.4 47252.3 47901.8 51357.7 44677.3 45420.5 45450.5 45620.3 46491.1 7567.4 7771.2 8031.1 8044.3 8229.1 31357.7 31861.4 32021.4 32192.4 32273.7 39993.4 40755.8 40774.6 41299.4 41328.8 9888.2 9950.3 10022.7 10058.2 10500.4 10701.2 10788.2 10946.8 11090.5 11106.9 9516.7 9655.5 10162.4 10267.8 10327.8 9414.8 9891.1 9902.7 10004.6 10035.7 9505.2 9569.2 9628.2 9802.4 10016.1 7601.8 7604.4 7651.7 7692.1 7890.7 7736.9 7752.7 7834.5 7914.1 7926.1 22:08:04 INFO - PROCESS | 1169 | -------- Summary: end -------- 22:08:04 INFO - PROCESS | 1169 | 22:08:04 INFO - TEST-INFO | 1169: exit 0 22:08:04 INFO - TEST-OK | dromaeo_css | took 1116103ms 22:08:04 INFO - TEST-START | kraken 22:08:04 INFO - operating with platform_type : linux_ 22:08:04 INFO - Initialising browser for kraken test... 22:08:04 INFO - TEST-INFO | started process 1476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjuwsS/profile http://localhost:51165/getInfo.html) 22:08:08 INFO - PROCESS | 1476 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 22:08:08 INFO - PROCESS | 1476 | 22:08:08 INFO - PROCESS | 1476 | (process:1543): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:09 INFO - PROCESS | 1476 | __metrics Screen width/height:1600/1200 22:08:09 INFO - PROCESS | 1476 | colorDepth:24 22:08:09 INFO - PROCESS | 1476 | Browser inner width/height: 1024/697 22:08:09 INFO - PROCESS | 1476 | __metrics 22:08:10 ERROR - PROCESS | 1476 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:08:11 INFO - TEST-INFO | 1476: exit 0 22:08:11 INFO - Browser initialized. 22:08:11 INFO - Running cycle 1/1 for kraken test... 22:08:11 INFO - TEST-INFO | started process 1594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjuwsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:13 INFO - PROCESS | 1594 | 22:08:13 INFO - PROCESS | 1594 | (process:1657): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:23 INFO - PROCESS | 1594 | RSS: Main: 164966400 22:08:23 INFO - PROCESS | 1594 | 22:08:25 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51165/tests/kraken/driver.html?testName=audio-beat-detection) 22:08:26 INFO - PROCESS | 1594 | RSS: Main: 168800256 22:08:26 INFO - PROCESS | 1594 | 22:08:29 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51165/tests/kraken/driver.html?testName=audio-dft) 22:08:30 INFO - PROCESS | 1594 | RSS: Main: 169127936 22:08:30 INFO - PROCESS | 1594 | 22:08:33 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51165/tests/kraken/driver.html?testName=audio-fft) 22:08:33 INFO - PROCESS | 1594 | RSS: Main: 163905536 22:08:33 INFO - PROCESS | 1594 | 22:08:36 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51165/tests/kraken/driver.html?testName=audio-oscillator) 22:08:36 INFO - PROCESS | 1594 | RSS: Main: 164311040 22:08:36 INFO - PROCESS | 1594 | 22:08:39 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:39 INFO - PROCESS | 1594 | RSS: Main: 164478976 22:08:39 INFO - PROCESS | 1594 | 22:08:42 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51165/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:43 INFO - PROCESS | 1594 | RSS: Main: 164421632 22:08:43 INFO - PROCESS | 1594 | 22:08:47 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51165/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:47 INFO - PROCESS | 1594 | RSS: Main: 163614720 22:08:47 INFO - PROCESS | 1594 | 22:08:50 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51165/tests/kraken/driver.html?testName=json-parse-financial) 22:08:51 INFO - PROCESS | 1594 | RSS: Main: 163946496 22:08:51 INFO - PROCESS | 1594 | 22:08:53 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:08:53 INFO - PROCESS | 1594 | RSS: Main: 164126720 22:08:53 INFO - PROCESS | 1594 | 22:08:55 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:08:56 INFO - PROCESS | 1594 | RSS: Main: 164208640 22:08:56 INFO - PROCESS | 1594 | 22:08:58 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:08:59 INFO - PROCESS | 1594 | RSS: Main: 164503552 22:08:59 INFO - PROCESS | 1594 | 22:09:02 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:09:02 INFO - PROCESS | 1594 | RSS: Main: 164384768 22:09:02 INFO - PROCESS | 1594 | 22:09:05 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:09:06 INFO - PROCESS | 1594 | RSS: Main: 164356096 22:09:06 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | Cycle 1(1): loaded http://localhost:51165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51165/tests/kraken/driver.html?testName=ai-astar) 22:09:08 INFO - PROCESS | 1594 | RSS: Main: 165847040 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | __start_tp_report 22:09:08 INFO - PROCESS | 1594 | _x_x_mozilla_page_load 22:09:08 INFO - PROCESS | 1594 | _x_x_mozilla_page_load_details 22:09:08 INFO - PROCESS | 1594 | |i|pagename|runs| 22:09:08 INFO - PROCESS | 1594 | |0;ai-astar;111;122;109;114;116;116;108;115;115;114 22:09:08 INFO - PROCESS | 1594 | |1;audio-beat-detection;151;131;156;217;138;154;164;133;184;136 22:09:08 INFO - PROCESS | 1594 | |2;audio-dft;163;163;167;168;163;162;163;162;164;163 22:09:08 INFO - PROCESS | 1594 | |3;audio-fft;76;77;76;180;79;76;76;75;158;77 22:09:08 INFO - PROCESS | 1594 | |4;audio-oscillator;93;93;173;92;94;94;145;93;91;156 22:09:08 INFO - PROCESS | 1594 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;117;118;118 22:09:08 INFO - PROCESS | 1594 | |6;imaging-darkroom;149;148;148;147;149;147;147;147;147;149 22:09:08 INFO - PROCESS | 1594 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;94 22:09:08 INFO - PROCESS | 1594 | |8;json-parse-financial;66;64;65;66;65;69;65;65;67;65 22:09:08 INFO - PROCESS | 1594 | |9;json-stringify-tinderbox;63;64;63;64;64;64;63;64;64;64 22:09:08 INFO - PROCESS | 1594 | |10;stanford-crypto-aes;81;81;83;82;89;85;83;83;147;87 22:09:08 INFO - PROCESS | 1594 | |11;stanford-crypto-ccm;134;131;138;129;133;134;131;131;152;143 22:09:08 INFO - PROCESS | 1594 | |12;stanford-crypto-pbkdf2;166;165;167;165;168;166;164;169;166;170 22:09:08 INFO - PROCESS | 1594 | |13;stanford-crypto-sha256-iterative;66;70;70;67;67;64;67;65;65;67 22:09:08 INFO - PROCESS | 1594 | __end_tp_report 22:09:08 INFO - PROCESS | 1594 | __start_cc_report 22:09:08 INFO - PROCESS | 1594 | _x_x_mozilla_cycle_collect,945 22:09:08 INFO - PROCESS | 1594 | __end_cc_report 22:09:08 INFO - PROCESS | 1594 | __startTimestamp1463202548538__endTimestamp 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | ------- Summary: start ------- 22:09:08 INFO - PROCESS | 1594 | Number of tests: 14 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:4.00 (3.5%) stddev-sans-first:4.09 22:09:08 INFO - PROCESS | 1594 | Values: 111.0 122.0 109.0 114.0 116.0 116.0 108.0 115.0 115.0 114.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:155.00 stddev:26.82 (17.3%) stddev-sans-first:28.38 22:09:08 INFO - PROCESS | 1594 | Values: 151.0 131.0 156.0 217.0 138.0 154.0 164.0 133.0 184.0 136.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.04 (1.3%) stddev-sans-first:2.15 22:09:08 INFO - PROCESS | 1594 | Values: 163.0 163.0 167.0 168.0 163.0 162.0 163.0 162.0 164.0 163.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:39.36 (51.8%) stddev-sans-first:41.14 22:09:08 INFO - PROCESS | 1594 | Values: 76.0 77.0 76.0 180.0 79.0 76.0 76.0 75.0 158.0 77.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:93.00 stddev:32.17 (34.6%) stddev-sans-first:33.35 22:09:08 INFO - PROCESS | 1594 | Values: 93.0 93.0 173.0 92.0 94.0 94.0 145.0 93.0 91.0 156.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:09:08 INFO - PROCESS | 1594 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 22:09:08 INFO - PROCESS | 1594 | Values: 149.0 148.0 148.0 147.0 149.0 147.0 147.0 147.0 147.0 149.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:09:08 INFO - PROCESS | 1594 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 94.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.50 stddev:1.42 (2.2%) stddev-sans-first:1.50 22:09:08 INFO - PROCESS | 1594 | Values: 66.0 64.0 65.0 66.0 65.0 69.0 65.0 65.0 67.0 65.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 22:09:08 INFO - PROCESS | 1594 | Values: 63.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:83.00 stddev:20.16 (24.3%) stddev-sans-first:21.11 22:09:08 INFO - PROCESS | 1594 | Values: 81.0 81.0 83.0 82.0 89.0 85.0 83.0 83.0 147.0 87.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:134.00 stddev:7.06 (5.3%) stddev-sans-first:7.46 22:09:08 INFO - PROCESS | 1594 | Values: 134.0 131.0 138.0 129.0 133.0 134.0 131.0 131.0 152.0 143.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:166.50 stddev:1.90 (1.1%) stddev-sans-first:2.00 22:09:08 INFO - PROCESS | 1594 | Values: 166.0 165.0 167.0 165.0 168.0 166.0 164.0 169.0 166.0 170.0 22:09:08 INFO - PROCESS | 1594 | 22:09:08 INFO - PROCESS | 1594 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.99 (3.0%) stddev-sans-first:2.09 22:09:08 INFO - PROCESS | 1594 | Values: 66.0 70.0 70.0 67.0 67.0 64.0 67.0 65.0 65.0 67.0 22:09:08 INFO - PROCESS | 1594 | -------- Summary: end -------- 22:09:08 INFO - PROCESS | 1594 | 22:09:09 INFO - TEST-INFO | 1594: exit 0 22:09:09 INFO - TEST-OK | kraken | took 64829ms 22:09:09 INFO - SUITE-END | took 1180s 22:09:09 INFO - Completed test suite (00:19:40) 22:09:09 INFO - javascript benchmark 22:09:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6421.28351951169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.10149599884, 2729.617853500509, 2750.161200833746, 2790.330320723027, 2794.3014246438393, 4793.592544633706, 4846.273059041146, 4859.975700121498, 4898.314236006961, 4899.461059283476, 4776.593989510887, 4853.854384368466, 4862.659613827033, 4870.4885986971385, 4892.070506603752, 4451.844185453501, 4484.977575112136, 4599.816007359702, 4605.631549476034, 4611.93082103767, 534.1932417776586, 4390.0, 4450.844220452284, 4549.886252843688, 4553.4991150973365, 4478.0, 4512.2329204035395, 4513.684042117053, 4520.412346394981, 4532.210425480946, 4424.0, 4541.750203738793, 4547.204239258117, 4552.0, 4585.656075794329, 4424.646028317727, 4451.732896026248, 4457.8439754608435, 4487.259602165639, 4492.865214043584, 4711.411073615798, 4731.124741922756, 4748.57262846342, 4754.402409109943, 4805.519448055166, 5119.283300337956, 5200.8959820803375, 5207.947920520822, 5208.0, 5275.208718692188, 5327.041132596131, 5358.517733404013, 5360.383555891083, 5370.355557333106, 5391.919121213185, 4949.703017818906, 4959.851204463872, 4963.776630051656, 4974.129527332775, 5008.9499105008845, 5189.455107213764, 5385.407605163429, 5396.271503346998, 5419.674819510842, 5454.045542030129, 5186.688798672092, 5225.346831646044, 5226.163813789775, 5232.529072383504, 5248.7900483980975, 5329.0, 5332.733363331896, 5336.279602253724, 5349.652272602269, 5387.784488620489, 5050.141475949097, 5174.560162386239, 5208.8958220835375, 5215.29593504872, 5229.764660590283, 4991.625628077909, 5152.433232344439, 5172.5603323717905, 5210.374755029421, 5220.112580861262, 4418.513963464016, 4428.756418396954, 4431.423914891108, 4438.622717069021, 4473.4408198975125, 3781.2248489059675, 3839.9424008639894, 3866.284737323604, 3887.047673319998, 3902.024493876531, 4612.97693511537, 4618.607418369476, 4620.676552641283, 4632.073585282957, 4649.04694537619, 5112.8721781955, 5328.0, 5374.274472946102, 5380.354357477049, 5415.0, 4555.2711566149255, 4583.564561366731, 4586.380838586815, 4590.793414296365, 4597.103564804898, 4747.192977193886, 4785.736784476887, 4786.353842231324, 4792.760361981887, 4802.927956080662, 4788.329633851194, 4859.125357435554, 5004.049230646311, 5014.774335155, 5031.169856973558, 5213.973930130325, 5231.843044708665, 5255.684658920477, 5264.921026184534, 5312.946870531246, 4895.4859739728245, 4923.0, 4927.581155601814, 4931.3835770528685, 4973.378327709036, 5069.6197785167, 5157.200633901752, 5170.793168273377, 5183.637145399785, 5194.97402512985, 5286.524212820865, 5311.521963023347, 5312.229726689531, 5319.654222475527, 5343.332083489564, 5103.336566246364, 5106.259592359162, 5108.693478391308, 5110.207917772751, 5160.793568257378, 4873.317735517101, 5045.11710450677, 5104.0, 5109.437961824122, 5112.565431938327, 4789.066132104206, 5026.623003274842, 5030.798768049383, 5073.365829271341, 5123.666961647481, 5243.161094224905, 5254.238135470412, 5254.527092561688, 5266.762995665128, 5308.442613525524, 4839.588634965927, 5003.4246061701915, 5017.422996355466, 5149.794008239778, 5160.819371321985], "value": 4794.195950592097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8313864271398, 603.5624172474957, 603.9607425517338, 617.8609812792121, 639.8592309691866, 37202.0, 41729.79135104328, 41774.79112604433, 41778.164436711246, 41886.58113418865, 42790.57209427905, 43156.0, 43536.12927741443, 43573.78213108938, 43628.781856090754, 7877.960610196941, 8051.194880511961, 8056.113827479002, 8059.919400805976, 8080.797980050487, 8009.67961281548, 8087.595620218995, 8093.39299552533, 8102.959485202566, 8113.797155071141, 8092.069412017605, 8107.594620268992, 8113.675452981874, 8118.0, 8139.552324622144, 8046.316063134641, 8059.717909873156, 8063.395245356622, 8077.071136819282, 8083.676652933876, 7851.254130857559, 7942.126366099725, 7954.880676789853, 7992.280694737501, 7992.720254791055, 32032.83983580067, 39337.21325573473, 39679.8016009921, 39799.20401591981, 39848.0, 3178.8887388941507, 3329.8002119872885, 3422.9828850855833, 3892.6691231245377, 3983.4821473208585, 28305.15084547467, 28361.716382836115, 28842.134735957956, 30252.697473025208, 30303.393932121235, 3180.1413618323154, 3192.776505644606, 3234.5633339499336, 3236.271838836243, 3247.0745837436452, 242415.0, 243585.0, 243586.0, 244144.77927610427, 246160.0, 33660.663393366245, 34206.82896585551, 34310.65689343074, 34354.656453435644, 34410.0, 34439.82780086083, 36120.458193127124, 36187.81906090453, 36216.81891590525, 36269.45595816065, 14290.928545357207, 14491.058081224686, 14538.200398978157, 14538.927305363406, 14568.781468277984, 11757.176997610257, 12021.338826364634, 12073.0, 12084.939575302067, 12104.334261615695, 8404.495730256203, 8430.915690843136, 8461.23848853606, 8517.0, 8535.743927682179, 3213.903582892517, 3245.9126192725703, 3261.6901394367496, 3272.836358182129, 3278.885239016623, 862.905080441151, 899.3128174484561, 919.2921450483224, 923.169147767015, 951.9000504946881, 28612.856935715605, 28993.56509652357, 29028.7097129026, 29094.709052909624, 29409.411811763646, 902.3863772634671, 923.3997901364168, 963.6482683820356, 985.9992108010375, 993.4982833668951, 15180.396527510567, 15442.45951391696, 15570.766438503431, 15598.688026239639, 15797.0, 401466.0, 405069.0, 405479.0, 407243.0, 408672.0, 52361.0, 53159.0, 53164.0, 53293.0, 53299.20051199235, 1236.71555542224, 1254.9458454897929, 1263.5135472842837, 1289.1942535915052, 1300.570811632178, 27078.864605676845, 28557.571636425055, 28971.7102828969, 31417.0, 32058.35883282368, 42770.144597108505, 42999.0, 43185.0, 43185.13629727325, 43239.35140972951, 386154.0, 392202.0, 396248.0, 396961.0, 398124.0, 39972.80013599913, 40319.79840100781, 40553.391699123946, 40715.592844072366, 41376.793116035435, 44434.33348499711, 44703.0, 44971.77514112408, 45817.312740308254, 46030.53969460396, 37749.245015100096, 38173.0, 38635.61364386432, 38880.41679374755, 39754.0, 37465.85637455856, 38234.23531529409, 38260.426093609174, 38830.2233955325, 39241.6075839238, 35189.29621407609, 37701.81149094237, 38339.80830095831, 39417.2116557673, 42171.7891410541, 32545.021042039243, 33436.33127337391, 33899.83050084734, 34456.0, 34502.65497344994, 26372.208833735018, 26555.601665975413, 26877.865610671823, 27010.459790804467, 27462.725372746016], "value": 17256.955487559386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.67099281639344, 376.90388950817544, 379.747467933824, 389.63569062926183, 390.859290655364, 16333.18334083297, 16863.32546698132, 17819.910900445513, 17837.732434013502, 18478.2608695652, 10703.464826758669, 11116.555337786478, 11256.268342557729, 11281.943590282057, 11309.773804523926, 3514.4728290756334, 4576.3296396815085, 4646.5121162278065, 4767.11808315461, 4782.378290822188, 5199.974000129994, 5465.398806131322, 5518.834434966937, 5571.8607034824045, 5597.916031259534, 4975.3283306753665, 5522.22688823563, 5525.392206857243, 5545.528630066449, 5551.916721249164, 5238.842834714946, 5304.6286759926825, 5326.840194794182, 5340.305760251143, 5361.490658387466, 5035.496450354972, 5350.652207606493, 5367.677939323653, 5386.946130538723, 5395.082835917864, 12415.75168496634, 12623.242605443702, 12873.67815804603, 12919.870801291961, 12928.0, 1885.3118611706766, 1938.37002974034, 2009.849261305408, 2025.8379329653592, 2543.7074736405366, 8611.397202195849, 8911.509866957314, 9180.908190918071, 9235.630574777, 9556.90443095567, 1805.900675462849, 1807.1957978699484, 1939.8157175068345, 2002.4192984034612, 2006.0772044859382, 70376.0, 72134.63932680304, 72225.63887180583, 72977.99999999948, 73587.26412735911, 10230.488475576192, 10255.641052563275, 10307.896921030844, 10401.895981040092, 10427.895721042692, 14011.08927919682, 14038.71922561543, 14087.225202613954, 14095.224762637949, 14151.221682807338, 7349.926500735031, 7606.581638009852, 7623.428242881806, 7670.348020418327, 7744.148143704188, 6943.166819981533, 7078.292170782984, 7347.669354879044, 7501.962490187514, 7511.887321690179, 4362.912741745147, 4463.107378524243, 4474.753888536096, 4489.775511224491, 4584.220682483919, 1657.8176400595926, 1755.1312100510074, 1854.332440321483, 1864.5991111911005, 1881.3697411367345, 828.3828547731857, 903.5888670654837, 986.8865080515833, 991.3457118302031, 998.4608311511703, 16235.350585976428, 17055.061971591433, 17220.569485762706, 17413.390531331344, 17527.82472175262, 828.1759649149135, 833.4582521361043, 875.9781005474787, 880.4673172730406, 924.4176169013479, 8679.26226270774, 9641.469719165372, 9711.902880971242, 9803.901960980442, 9867.654632087842, 318701.0, 324789.0, 325050.0, 402517.0, 407834.0, 82165.0, 86287.56856215805, 86571.0, 87895.1210487887, 87935.56032219798, 944.8204841080172, 958.5399008475971, 958.5830163878595, 970.3401686852867, 992.2211064314479, 15443.0, 15771.763423548886, 15917.0, 16188.757168642715, 16424.0, 37042.0, 37685.2462950734, 37896.81051594725, 38144.42783358196, 38358.6164138355, 50604.0, 52665.7366713164, 54315.18527222174, 54500.72749636226, 55094.44905551054, 7723.1118421380015, 7804.492707973964, 7835.49069310493, 7960.442769006114, 7966.402519810921, 11267.774644507228, 11893.524259029888, 12081.516739330329, 12280.324582148067, 12329.691757706129, 10605.575776968835, 10676.83984740214, 10731.731706707395, 10785.514651840529, 10864.293820901616, 9836.3606365586, 9841.507924603884, 10176.949115254376, 10443.425611591436, 11013.394263315595, 10635.840462392916, 11011.119110470983, 11069.335839849635, 11073.446327683745, 11284.830727538929, 7890.723824666339, 7923.0, 7924.524528528307, 8015.238552337519, 8040.437169398086, 9767.706968790948, 10669.786604268027, 10865.402402867918, 10880.782384352427, 10931.18016148776], "value": 8184.866732324333, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.4296495849098, 1516.8710659593935, 1659.178706540262, 1767.9381221657245, 1805.1786437171088, 6897.758578449755, 7755.612219389036, 7795.493292935969, 8279.172082791718, 8326.417150799454, 7830.9216907830905, 8086.636101375438, 8096.433249672526, 8113.797155071112, 8144.1448647892, 2256.4133325335406, 2287.0508738873345, 2290.564792689392, 2295.173737454515, 2300.4133945843787, 2227.354067320475, 2243.540074284768, 2288.8168946484325, 2297.104129389531, 2305.43516838374, 2242.237639202671, 2244.820414366855, 2249.527599204161, 2295.7130358705163, 2296.5062511560013, 2243.113969981848, 2251.538434620899, 2294.9426264343356, 2295.6326987681973, 2302.2057390200353, 2244.5847518209184, 2266.161520237523, 2267.648514480242, 2268.9886550567307, 2272.45461089339, 8128.268455839003, 8187.304079153279, 8189.426740128193, 8194.180581941817, 8207.794805129919, 4791.137595232856, 4940.184869496528, 4949.084419382426, 4951.90096198074, 4958.2562615607585, 2850.144956513038, 2880.3375223698667, 3056.8777248910237, 3076.8769249230004, 3076.9076927692204, 908.8866138979763, 932.8274269260208, 961.4615815143542, 970.5875003123645, 983.1593987140963, 11005.394703291317, 11021.118310535137, 11076.889231107747, 11102.55589776408, 11131.777364452666, 4397.604215620546, 4459.3979812724865, 4525.185466616041, 4548.385967894358, 4568.428946381702, 9578.329516933887, 9654.517274136266, 9656.806863862683, 9662.468564229035, 9687.70936871895, 4814.277858321279, 4838.032393521239, 4852.927206091911, 4856.78144483492, 4864.270359446112, 3832.904177395532, 4148.377743338463, 4170.9582904171175, 4378.124375124988, 4537.705049171794, 3762.0, 3844.0, 3926.1755031443718, 3944.5069366329208, 4058.1477889642915, 1230.8276841242234, 1239.8388209532702, 1241.6895776055985, 1246.401727170963, 1254.4319600499375, 760.7717684694569, 918.4397517514311, 929.9070092990647, 929.9070092990647, 930.186087173723, 5470.316210473691, 5507.944920550824, 5564.944350556523, 5611.3266408031295, 5693.572982026365, 879.8548239540404, 913.1142791492242, 913.1142791492242, 924.9630014799467, 928.4986107501874, 3530.3998320285614, 3620.6741393274206, 3632.72754543405, 3637.672609465161, 3655.3785856403942, 9842.753931151636, 9976.45129517869, 10001.749956251006, 10143.847842282372, 10204.285700001077, 9964.0, 10048.79902401948, 10077.445740484198, 10082.747931301776, 10105.949470252748, 7571.3942884569105, 7600.2779735925, 7754.495957762728, 7766.301032907066, 7786.454948153688, 5328.6802791832615, 5336.7598458068705, 5388.595855310789, 5557.944420555743, 5629.155626656035, 8993.955030224806, 9049.366544342096, 9183.724488265363, 9188.586513607037, 9207.263418926605, 9142.085791420805, 9293.25653947669, 9341.252699783865, 9411.341206115507, 9439.52802359893, 6196.287426945959, 6666.2333831609985, 6845.247022827584, 7048.224695283412, 7098.964505177441, 7863.685452582062, 7879.054513458422, 7890.881636775338, 7929.088154862265, 7957.244061814118, 6929.618870962146, 6997.790066298019, 7064.823379415556, 7146.821329466805, 7168.462365322517, 7028.613426261605, 7065.116860392451, 7092.574445533284, 7110.43116550685, 7256.7822965311125, 6463.159789227559, 6704.0, 6715.56348837324, 6726.260111387645, 6837.3162683731225, 4969.105560999054, 5007.5993920487, 5030.723310217827, 5034.521720436553, 5079.16193828029, 4933.481984391731, 4970.726610036338, 4975.353204083591, 4986.376702912136, 5032.270320803536], "value": 4342.936218332743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.9348690031643, 306.90485949355696, 309.71506214282874, 315.97314228290594, 317.2718610788241, 5059.266406371074, 5102.209157580576, 5102.668326558775, 5120.129577971745, 5160.071187186314, 5018.5985121190215, 5027.773750181242, 5048.510689346643, 5068.797248110081, 5073.416557095926, 3737.570179429373, 3862.613738626129, 3964.6630036446936, 3971.86098486553, 3982.681385489154, 3930.410438434229, 3959.109200429909, 3960.4257382679493, 3967.642912137907, 3973.9801300993454, 3910.081130934228, 3925.7840818754958, 3954.228925359556, 3957.2876882161345, 3971.4439978403047, 3797.5505798759646, 3940.281205967873, 3957.960420395788, 3958.4062390641348, 3962.48487696599, 3471.4831746983486, 3497.1956450016637, 3498.5451891253974, 3504.8247587620517, 3505.2288496530978, 4711.623070154379, 4751.714897106184, 4795.568398844121, 4796.56830885222, 4836.709797412166, 4428.158649856549, 4499.302608095751, 4532.229520981441, 4543.636509079266, 4547.24970379887, 5261.86845328866, 5291.788328466857, 5295.881647341056, 5298.655587386807, 5321.8935621287355, 3809.733318667694, 3814.275287695357, 3816.122291872857, 3820.732548721591, 3830.176512049895, 5446.183072539072, 5546.251256080418, 5555.694436805974, 5563.221149039137, 5588.91616625751, 3885.8639947602264, 3886.417037444406, 3902.1610353774076, 3917.05990562263, 3920.9803950980063, 3941.3890846918775, 3972.741771784825, 3974.8012599370495, 3978.5424676162033, 3985.1830374773103, 4462.107578484316, 4497.617702495259, 4497.752623605667, 4503.0, 4506.062393170902, 4971.6136254598, 5268.236105764643, 5272.657277276965, 5319.255304257407, 5322.201669749491, 1316.5457917018614, 1332.5935589645057, 1344.9125806822722, 1345.219772531929, 1352.1008529327887, 806.209914284005, 826.3182874128868, 842.8651415773447, 849.2993280543576, 856.7772379181457, 4579.95420045802, 4654.766486880979, 4680.315086568832, 4680.7191568506, 4688.132695451352, 5453.23654688344, 5466.835994920079, 5485.972570137204, 5491.395946445888, 5505.779768809283, 4454.5990860822685, 4689.648276379217, 4693.0, 4710.704556246991, 4722.386089808303, 2868.9815115634065, 2893.4936386132345, 2895.7683385329124, 2900.550414685727, 2905.5205891027745, 5068.0, 5099.821506247264, 5101.066886540254, 5106.463821298785, 5124.078470573535, 5449.237106805051, 5483.862903427446, 5607.943920560742, 5608.915866262009, 5627.539063475932, 5093.668911520739, 5117.437081920985, 5144.948550514522, 5161.380634323905, 5176.938727560841, 5447.891042179055, 5454.3454785426, 5463.153211252262, 5477.45225477465, 5492.423295553909, 5108.821191258288, 5285.788568457218, 5304.859455217147, 5358.892822143457, 5372.785088596413, 5102.43873173958, 5115.746642072567, 5131.79472821083, 5132.8460146195675, 5138.4604616514725, 3773.9245215096093, 3784.8296826642318, 3788.5643151037984, 3800.2969450651717, 3808.714346424085, 5257.4216836147225, 5401.459854014567, 5432.29380180574, 5468.0, 5536.861578460571, 5257.4742525747115, 5267.971830845228, 5294.602904782079, 5302.655327403706, 5303.893922121459, 5273.734303766992, 5281.260623512788, 5284.313039304866, 5308.893822123458, 5315.920261196008, 4980.277859710394, 5244.7639856207325, 5262.289590905179, 5262.500062494057, 5271.367435907716, 5125.846224613268, 5193.68837869729, 5318.228856815663, 5329.893402131858, 5330.360356757214, 5178.97410512945, 5197.298364720715, 5197.402298735694, 5206.219067139959, 5214.817481388133], "value": 3981.6757207434607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9862602747944, 729.3217307903651, 768.6272158003371, 809.2676128104064, 848.1857416879795, 11510.539578416863, 13003.154794938335, 13051.41268642911, 13060.151090179132, 13161.539346122887, 12717.872821271785, 12773.361331933389, 12791.936040319808, 12799.616011519645, 12809.487620495192, 704.5455681085697, 869.504382501971, 880.6521424037518, 896.256107430834, 898.4474548152872, 884.6815146547237, 886.2112719679491, 887.0951629338072, 888.0586578227068, 889.5952341684518, 935.1069728409353, 940.0082912527281, 941.0918463682546, 942.0673533202115, 943.9150476457118, 928.6007016982695, 929.8744669469603, 932.7108596335158, 937.3251259093441, 938.1322276893914, 683.9247682754893, 687.8039758668806, 688.1604442580044, 688.1707542411382, 688.7004153193377, 11930.22453540517, 12011.459484323226, 12033.518659253707, 12042.939785301105, 12060.577879774166, 12608.936955315256, 12609.919363305044, 12697.746045079046, 12924.935375323157, 13078.476860925552, 9718.61125554977, 9803.803923921552, 9955.0, 10103.595856165744, 10154.847677284846, 3313.701766840996, 3333.183370074323, 3383.7462190335823, 3409.062507810347, 3417.2140407706365, 48343.51656483425, 48535.51464485345, 49082.754586227195, 50357.49642503601, 50574.0, 10327.793444131226, 10367.775136594264, 10387.792244155075, 10417.47912604382, 10503.842442363371, 19483.707744383562, 19588.412347629594, 19725.210991560463, 19837.60324793496, 20058.0, 6859.519833611699, 6922.653867306614, 6950.235474097845, 6982.650867456607, 7008.929910700827, 3818.770873747584, 3819.427085937132, 3834.0, 3927.509061367329, 3929.44987701722, 2857.4713677969644, 2953.394554116401, 2962.6296712910885, 2968.1095671298954, 2981.359007813287, 497.4701942431299, 499.7501249375312, 509.2997128947697, 515.5098204126012, 519.2574618295873, 588.2059220052894, 621.201755743867, 629.7204121081713, 633.3476519185247, 634.7810005548079, 8469.855341579578, 8724.43291186071, 8969.686060987835, 8969.955150224338, 9086.182243598108, 495.7446914838861, 505.6283631530822, 510.10985829727366, 510.67061745174897, 553.5654511208681, 3776.4712940188397, 3814.6757525610633, 3885.747426417274, 3914.236723838881, 3921.8039098044983, 53086.46913530892, 54697.1795423069, 55015.44984550183, 55125.0, 55201.0, 37042.44436333457, 37058.44412333817, 47252.29121563179, 47901.76049119732, 51357.743211283705, 44677.32984005242, 45420.54579454229, 45450.545494545295, 45620.315695264595, 46491.070178596914, 7567.432442566939, 7771.239022050626, 8031.076426210827, 8044.2760151586635, 8229.094799572162, 31357.686423135478, 31861.362772743953, 32021.35957280888, 32192.35615287728, 32273.677263228008, 39993.400098997954, 40755.7962210187, 40774.59225407708, 41299.38050929298, 41328.79335603303, 9888.159506442033, 9950.322975250754, 10022.699319020441, 10058.245631577514, 10500.369977801356, 10701.204471044344, 10788.244822862323, 10946.835797462885, 11090.500927458123, 11106.944465277622, 9516.714498565054, 9655.517224138624, 10162.39025658463, 10267.794644106927, 10327.845082323922, 9414.764630884283, 9891.109800118023, 9902.653407130716, 10004.599816007569, 10035.69892903214, 9505.192058674813, 9569.186619137452, 9628.191312379962, 9802.36284641496, 10016.098551130433, 7601.847963040819, 7604.353629941517, 7651.693932242871, 7692.076950765944, 7890.723824666109, 7736.92263077362, 7752.689892404241, 7834.529928204326, 7914.129445761077, 7926.128125906261], "value": 5986.121683319406, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 109.0, 114.0, 116.0, 116.0, 108.0, 115.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 156.0, 217.0, 138.0, 154.0, 164.0, 133.0, 184.0, 136.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 167.0, 168.0, 163.0, 162.0, 163.0, 162.0, 164.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 180.0, 79.0, 76.0, 76.0, 75.0, 158.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 173.0, 92.0, 94.0, 94.0, 145.0, 93.0, 91.0, 156.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 66.0, 65.0, 69.0, 65.0, 65.0, 67.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 82.0, 89.0, 85.0, 83.0, 83.0, 147.0, 87.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 138.0, 129.0, 133.0, 134.0, 131.0, 131.0, 152.0, 143.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 165.0, 168.0, 166.0, 164.0, 169.0, 166.0, 170.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 70.0, 67.0, 67.0, 64.0, 67.0, 65.0, 65.0, 67.0], "value": 66.8, "unit": "score"}]}]} 22:09:09 INFO - Return code: 0 22:09:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:09:09 ERROR - # TBPL SUCCESS # 22:09:09 INFO - Running post-action listener: _resource_record_post_action 22:09:09 INFO - ##### 22:09:09 INFO - ##### Finished run-tests step (success) 22:09:09 INFO - ##### 22:09:09 INFO - Running post-run listener: _resource_record_post_run 22:09:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 538464256; Read time: 0; Write time: 429160 22:09:09 INFO - TinderboxPrint: CPU usage
13.4% 22:09:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:09:09 INFO - TinderboxPrint: I/O write bytes / time
538,464,256 / 429,160 22:09:09 INFO - TinderboxPrint: CPU idle
8,275.3 (86.6%) 22:09:09 INFO - TinderboxPrint: CPU user
1,229.2 (12.9%) 22:09:09 INFO - TinderboxPrint: Swap in / out
0 / 0 22:09:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243302400; Read time: 0; Write time: 235108 22:09:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295161856; Read time: 0; Write time: 194052 22:09:10 INFO - Running post-run listener: _upload_blobber_files 22:09:10 INFO - Blob upload gear active. 22:09:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:09:10 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 22:09:10 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'] 22:09:10 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 22:09:10 INFO - (blobuploader) - INFO - Open directory for files ... 22:09:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:09:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:11 INFO - (blobuploader) - INFO - Done attempting. 22:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:09:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:15 INFO - (blobuploader) - INFO - Done attempting. 22:09:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:09:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:09:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:16 INFO - (blobuploader) - INFO - Done attempting. 22:09:16 INFO - (blobuploader) - INFO - Iteration through files over. 22:09:16 INFO - Return code: 0 22:09:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:09:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:09:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f7444e6bf75a19e9faa2e0cf4b8827f3121567cfae2e33a4d571ebd4f12521c69e9ea262aacb4fe072df8117a77cbd0af5b13a3d1d79f5b695361100874db4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8ff5679b5be0ba8b0f482075924e7cfa6bbc50f1f220e998ac946b8937066bb845c6026bed773562371bd3ef6e6b09533393e88f781c859e950fa3dfe70ac2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ebfdf737cc3f74fcfbc10d1ddda0b5ee100ae16acf81050b021a12cff56f4168a1e0f7cc237c2727ce7844046770018bfd8d183c08ef45b3af7ce7af537067"} 22:09:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:09:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:09:16 INFO - Contents: 22:09:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f7444e6bf75a19e9faa2e0cf4b8827f3121567cfae2e33a4d571ebd4f12521c69e9ea262aacb4fe072df8117a77cbd0af5b13a3d1d79f5b695361100874db4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8ff5679b5be0ba8b0f482075924e7cfa6bbc50f1f220e998ac946b8937066bb845c6026bed773562371bd3ef6e6b09533393e88f781c859e950fa3dfe70ac2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ebfdf737cc3f74fcfbc10d1ddda0b5ee100ae16acf81050b021a12cff56f4168a1e0f7cc237c2727ce7844046770018bfd8d183c08ef45b3af7ce7af537067"} 22:09:16 INFO - Running post-run listener: copy_logs_to_upload_dir 22:09:16 INFO - Copying logs to upload dir... 22:09:16 INFO - mkdir: /builds/slave/test/build/upload/logs 22:09:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.272494 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-13 22:09:16.241070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 22:09:16.244934) ========= 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=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f7444e6bf75a19e9faa2e0cf4b8827f3121567cfae2e33a4d571ebd4f12521c69e9ea262aacb4fe072df8117a77cbd0af5b13a3d1d79f5b695361100874db4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8ff5679b5be0ba8b0f482075924e7cfa6bbc50f1f220e998ac946b8937066bb845c6026bed773562371bd3ef6e6b09533393e88f781c859e950fa3dfe70ac2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ebfdf737cc3f74fcfbc10d1ddda0b5ee100ae16acf81050b021a12cff56f4168a1e0f7cc237c2727ce7844046770018bfd8d183c08ef45b3af7ce7af537067"} build_url:https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/O2hlyNdERte4lRHSrRl7rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f7444e6bf75a19e9faa2e0cf4b8827f3121567cfae2e33a4d571ebd4f12521c69e9ea262aacb4fe072df8117a77cbd0af5b13a3d1d79f5b695361100874db4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8ff5679b5be0ba8b0f482075924e7cfa6bbc50f1f220e998ac946b8937066bb845c6026bed773562371bd3ef6e6b09533393e88f781c859e950fa3dfe70ac2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ebfdf737cc3f74fcfbc10d1ddda0b5ee100ae16acf81050b021a12cff56f4168a1e0f7cc237c2727ce7844046770018bfd8d183c08ef45b3af7ce7af537067"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 22:09:16.269583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 22:09:16.269936) ========= 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=d2a8c569965ab8367867b893000001a1-1463198398.110380-94581762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 22:09:16.353594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 22:09:16.353920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 22:09:16.354253) ========= ========= Total master_lag: 0.17 =========