builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1463379408.88 results: success (0) buildid: 20160515203030 builduid: 02e0608df6234392a70b43c1c3665b4f revision: 7084bd828e4c688daf6078a710d2f267bb52591a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:48.878880) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:48.879342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:48.879617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:48.904227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:48.904484) ========= 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=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-15 23:16:49-- 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% 70.4M=0s 2016-05-15 23:16:49 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.025345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.025668) ========= 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=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014548 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.074469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.074823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7084bd828e4c688daf6078a710d2f267bb52591a --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 7084bd828e4c688daf6078a710d2f267bb52591a --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=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-15 23:16:49,457 truncating revision to first 12 chars 2016-05-15 23:16:49,457 Setting DEBUG logging. 2016-05-15 23:16:49,457 attempt 1/10 2016-05-15 23:16:49,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7084bd828e4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-15 23:16:49,722 unpacking tar archive at: fx-team-7084bd828e4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.672948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.673230) ========= script_repo_revision: 7084bd828e4c688daf6078a710d2f267bb52591a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.673619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.673895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-15 23:16:49.681852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-15 23:16:49.682123) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:50 INFO - MultiFileLogger online at 20160515 23:16:50 in /builds/slave/test 23:16:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:16:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:50 INFO - {'append_to_log': False, 23:16:50 INFO - 'base_work_dir': '/builds/slave/test', 23:16:50 INFO - 'blob_upload_branch': 'Fx-Team', 23:16:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:50 INFO - 'branch': 'Fx-Team', 23:16:50 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:50 INFO - 'config_files': ('talos/linux_config.py',), 23:16:50 INFO - 'default_actions': ('clobber', 23:16:50 INFO - 'read-buildbot-config', 23:16:50 INFO - 'download-and-extract', 23:16:50 INFO - 'populate-webroot', 23:16:50 INFO - 'create-virtualenv', 23:16:50 INFO - 'install', 23:16:50 INFO - 'run-tests'), 23:16:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:50 INFO - 'download_minidump_stackwalk': True, 23:16:50 INFO - 'download_symbols': 'ondemand', 23:16:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:50 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:50 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:50 INFO - 'installer_path': 'installer.exe', 23:16:50 INFO - 'log_level': 'info', 23:16:50 INFO - 'log_name': 'talos', 23:16:50 INFO - 'log_to_console': True, 23:16:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:50 INFO - 'opt_config_files': (), 23:16:50 INFO - 'pip_index': False, 23:16:50 INFO - 'sps_profile': False, 23:16:50 INFO - 'sps_profile_interval': 0, 23:16:50 INFO - 'suite': 'dromaeojs-e10s', 23:16:50 INFO - 'system_bits': '32', 23:16:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:50 INFO - 'title': 'talos-linux64-ix-020', 23:16:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:50 INFO - 'use_talos_json': True, 23:16:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:50 INFO - 'work_dir': 'build'} 23:16:50 INFO - ##### 23:16:50 INFO - ##### Running clobber step. 23:16:50 INFO - ##### 23:16:50 INFO - Running pre-action listener: _resource_record_pre_action 23:16:50 INFO - Running main action method: clobber 23:16:50 INFO - rmtree: /builds/slave/test/build 23:16:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:50 INFO - Running post-action listener: _resource_record_post_action 23:16:50 INFO - ##### 23:16:50 INFO - ##### Finished clobber step (success) 23:16:50 INFO - ##### 23:16:50 INFO - ##### 23:16:50 INFO - ##### Running read-buildbot-config step. 23:16:50 INFO - ##### 23:16:50 INFO - Running pre-action listener: _resource_record_pre_action 23:16:50 INFO - Running main action method: read_buildbot_config 23:16:50 INFO - Using buildbot properties: 23:16:50 INFO - { 23:16:50 INFO - "project": "", 23:16:50 INFO - "product": "firefox", 23:16:50 INFO - "script_repo_revision": "production", 23:16:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:16:50 INFO - "repository": "", 23:16:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:16:50 INFO - "buildid": "20160515203030", 23:16:50 INFO - "pgo_build": "True", 23:16:50 INFO - "basedir": "/builds/slave/test", 23:16:50 INFO - "buildnumber": 746, 23:16:50 INFO - "slavename": "talos-linux64-ix-020", 23:16:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:16:50 INFO - "platform": "ubuntu64_hw", 23:16:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:16:50 INFO - "branch": "fx-team", 23:16:50 INFO - "repo_path": "integration/fx-team", 23:16:50 INFO - "revision": "7084bd828e4c688daf6078a710d2f267bb52591a", 23:16:50 INFO - "stage_platform": "linux64-pgo", 23:16:50 INFO - "builduid": "02e0608df6234392a70b43c1c3665b4f", 23:16:50 INFO - "slavebuilddir": "test" 23:16:50 INFO - } 23:16:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:16:50 INFO - Running post-action listener: _resource_record_post_action 23:16:50 INFO - ##### 23:16:50 INFO - ##### Finished read-buildbot-config step (success) 23:16:50 INFO - ##### 23:16:50 INFO - ##### 23:16:50 INFO - ##### Running download-and-extract step. 23:16:50 INFO - ##### 23:16:50 INFO - Running pre-action listener: _resource_record_pre_action 23:16:50 INFO - Running main action method: download_and_extract 23:16:50 INFO - mkdir: /builds/slave/test/build/tests 23:16: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')]} 23:16:50 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:52 INFO - Downloaded 1361 bytes. 23:16:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:16:52 INFO - Using the following test package requirements: 23:16:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'jsshell-linux-x86_64.zip'], 23:16:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16: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')]} 23:16:52 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:53 INFO - Downloaded 24023288 bytes. 23:16:53 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'] 23:16:53 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 23:16:55 INFO - Return code: 0 23:16:55 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 23:16: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')]} 23:16:55 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:56 INFO - Downloaded 24023288 bytes. 23:16:56 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'] 23:16:56 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 23:16:57 INFO - Return code: 0 23:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:16:57 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:58 INFO - Downloaded 10840194 bytes. 23:16:58 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'] 23:16:58 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 23:16:58 INFO - Return code: 0 23:16: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')]} 23:16:58 INFO - https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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 23:17:00 INFO - Downloaded 58394741 bytes. 23:17:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:00 INFO - mkdir: /builds/slave/test/properties 23:17:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:17:00 INFO - Writing to file /builds/slave/test/properties/build_url 23:17:00 INFO - Contents: 23:17:00 INFO - build_url:https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:01 INFO - Running post-action listener: _resource_record_post_action 23:17:01 INFO - Running post-action listener: set_extra_try_arguments 23:17:01 INFO - ##### 23:17:01 INFO - ##### Finished download-and-extract step (success) 23:17:01 INFO - ##### 23:17:01 INFO - ##### 23:17:01 INFO - ##### Running populate-webroot step. 23:17:01 INFO - ##### 23:17:01 INFO - Running pre-action listener: _resource_record_pre_action 23:17:01 INFO - Running main action method: populate_webroot 23:17:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:17:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:17:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:17:01 INFO - '--tppagecycles', 23:17:01 INFO - '7'], 23:17:01 INFO - 'tests': ['tsvgm']}}, 23:17:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:17:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:17:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:17:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:17:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['damp', 'tps']}, 23:17:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'tests': ['damp', 'tps']}, 23:17:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['dromaeo_dom']}, 23:17:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:17:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'other-e10s': {'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['a11yr', 23:17:01 INFO - 'ts_paint', 23:17:01 INFO - 'tpaint', 23:17:01 INFO - 'sessionrestore', 23:17:01 INFO - 'sessionrestore_no_auto_restore', 23:17:01 INFO - 'tabpaint']}, 23:17:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['tsvgx', 23:17:01 INFO - 'tsvgr_opacity', 23:17:01 INFO - 'tart', 23:17:01 INFO - 'tscrollx', 23:17:01 INFO - 'cart']}, 23:17:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:17:01 INFO - 'tsvgr_opacity', 23:17:01 INFO - 'tart', 23:17:01 INFO - 'tscrollx', 23:17:01 INFO - 'cart']}, 23:17:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'talos_options': ['--disable-e10s'], 23:17:01 INFO - 'tests': ['tp5o']}, 23:17:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'tests': ['tp5o']}, 23:17:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'talos_options': ['--disable-e10s', 23:17:01 INFO - '--xperf_path', 23:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:01 INFO - 'tests': ['tp5n']}, 23:17:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:01 INFO - 'talos_options': ['--xperf_path', 23:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:01 INFO - 'tests': ['tp5n']}}, 23:17:01 INFO - 'talos.zip': {'path': '', 23:17:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:17:01 INFO - Running post-action listener: _resource_record_post_action 23:17:01 INFO - ##### 23:17:01 INFO - ##### Finished populate-webroot step (success) 23:17:01 INFO - ##### 23:17:01 INFO - ##### 23:17:01 INFO - ##### Running create-virtualenv step. 23:17:01 INFO - ##### 23:17:01 INFO - Running pre-action listener: _resource_record_pre_action 23:17:01 INFO - Running main action method: create_virtualenv 23:17:01 INFO - Creating virtualenv /builds/slave/test/build/venv 23:17:01 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 23:17:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:17:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:17:01 INFO - Using real prefix '/usr' 23:17:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:17:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:17:03 INFO - Installing pip.................done. 23:17:03 INFO - Return code: 0 23:17:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:17:03 INFO - Using env: {'DISPLAY': ':0', 23:17:03 INFO - 'HOME': '/home/cltbld', 23:17:03 INFO - 'LANG': 'en_US.UTF-8', 23:17:03 INFO - 'LANGUAGE': 'en_US:en', 23:17:03 INFO - 'LOGNAME': 'cltbld', 23:17:03 INFO - 'MAIL': '/var/mail/cltbld', 23:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:03 INFO - 'MOZ_NO_REMOTE': '1', 23:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:03 INFO - 'NO_EM_RESTART': '1', 23:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:03 INFO - 'PWD': '/builds/slave/test', 23:17:03 INFO - 'SHELL': '/bin/bash', 23:17:03 INFO - 'SHLVL': '1', 23:17:03 INFO - 'TERM': 'linux', 23:17:03 INFO - 'TMOUT': '86400', 23:17:03 INFO - 'USER': 'cltbld', 23:17:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:03 INFO - '_': '/tools/buildbot/bin/python'} 23:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:03 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 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:17:03 INFO - Using env: {'DISPLAY': ':0', 23:17:03 INFO - 'HOME': '/home/cltbld', 23:17:03 INFO - 'LANG': 'en_US.UTF-8', 23:17:03 INFO - 'LANGUAGE': 'en_US:en', 23:17:03 INFO - 'LOGNAME': 'cltbld', 23:17:03 INFO - 'MAIL': '/var/mail/cltbld', 23:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:03 INFO - 'MOZ_NO_REMOTE': '1', 23:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:03 INFO - 'NO_EM_RESTART': '1', 23:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:03 INFO - 'PWD': '/builds/slave/test', 23:17:03 INFO - 'SHELL': '/bin/bash', 23:17:03 INFO - 'SHLVL': '1', 23:17:03 INFO - 'TERM': 'linux', 23:17:03 INFO - 'TMOUT': '86400', 23:17:03 INFO - 'USER': 'cltbld', 23:17:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:03 INFO - '_': '/tools/buildbot/bin/python'} 23:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:04 INFO - Downloading/unpacking psutil>=3.1.1 23:17:04 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 23:17:04 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 23:17:04 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 23:17:04 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 23:17:04 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 23:17:04 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 23:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:07 INFO - Installing collected packages: psutil 23:17:07 INFO - Running setup.py install for psutil 23:17:07 INFO - building 'psutil._psutil_linux' extension 23:17:07 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 23:17:07 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 23:17:07 INFO - building 'psutil._psutil_posix' extension 23:17:07 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 23:17:07 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 23:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:07 INFO - Successfully installed psutil 23:17:07 INFO - Cleaning up... 23:17:07 INFO - Return code: 0 23:17:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:17:07 INFO - Using env: {'DISPLAY': ':0', 23:17:07 INFO - 'HOME': '/home/cltbld', 23:17:07 INFO - 'LANG': 'en_US.UTF-8', 23:17:07 INFO - 'LANGUAGE': 'en_US:en', 23:17:07 INFO - 'LOGNAME': 'cltbld', 23:17:07 INFO - 'MAIL': '/var/mail/cltbld', 23:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:07 INFO - 'MOZ_NO_REMOTE': '1', 23:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:07 INFO - 'NO_EM_RESTART': '1', 23:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:07 INFO - 'PWD': '/builds/slave/test', 23:17:07 INFO - 'SHELL': '/bin/bash', 23:17:07 INFO - 'SHLVL': '1', 23:17:07 INFO - 'TERM': 'linux', 23:17:07 INFO - 'TMOUT': '86400', 23:17:07 INFO - 'USER': 'cltbld', 23:17:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:07 INFO - '_': '/tools/buildbot/bin/python'} 23:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:17: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 23:17: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 23:17: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 23:17: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 23:17: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 23:17: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 23:17:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:17:09 INFO - Installing collected packages: mozsystemmonitor 23:17:09 INFO - Running setup.py install for mozsystemmonitor 23:17:09 INFO - Successfully installed mozsystemmonitor 23:17:09 INFO - Cleaning up... 23:17:09 INFO - Return code: 0 23:17:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:17:09 INFO - Using env: {'DISPLAY': ':0', 23:17:09 INFO - 'HOME': '/home/cltbld', 23:17:09 INFO - 'LANG': 'en_US.UTF-8', 23:17:09 INFO - 'LANGUAGE': 'en_US:en', 23:17:09 INFO - 'LOGNAME': 'cltbld', 23:17:09 INFO - 'MAIL': '/var/mail/cltbld', 23:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:09 INFO - 'MOZ_NO_REMOTE': '1', 23:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:09 INFO - 'NO_EM_RESTART': '1', 23:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:09 INFO - 'PWD': '/builds/slave/test', 23:17:09 INFO - 'SHELL': '/bin/bash', 23:17:09 INFO - 'SHLVL': '1', 23:17:09 INFO - 'TERM': 'linux', 23:17:09 INFO - 'TMOUT': '86400', 23:17:09 INFO - 'USER': 'cltbld', 23:17:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:09 INFO - '_': '/tools/buildbot/bin/python'} 23:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:17: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 23:17: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 23:17: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 23:17: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 23:17: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 23:17: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 23:17:11 INFO - Downloading blobuploader-1.2.4.tar.gz 23:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:17:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:17:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:12 INFO - Downloading docopt-0.6.1.tar.gz 23:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:17:12 INFO - Installing collected packages: blobuploader, requests, docopt 23:17:12 INFO - Running setup.py install for blobuploader 23:17:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:17:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:17:12 INFO - Running setup.py install for requests 23:17:13 INFO - Running setup.py install for docopt 23:17:13 INFO - Successfully installed blobuploader requests docopt 23:17:13 INFO - Cleaning up... 23:17:13 INFO - Return code: 0 23:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:13 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')]} 23:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:13 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')]} 23:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:13 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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:13 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 23:17:13 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 23:17:13 INFO - Using env: {'DISPLAY': ':0', 23:17:13 INFO - 'HOME': '/home/cltbld', 23:17:13 INFO - 'LANG': 'en_US.UTF-8', 23:17:13 INFO - 'LANGUAGE': 'en_US:en', 23:17:13 INFO - 'LOGNAME': 'cltbld', 23:17:13 INFO - 'MAIL': '/var/mail/cltbld', 23:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:13 INFO - 'MOZ_NO_REMOTE': '1', 23:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:13 INFO - 'NO_EM_RESTART': '1', 23:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:13 INFO - 'PWD': '/builds/slave/test', 23:17:13 INFO - 'SHELL': '/bin/bash', 23:17:13 INFO - 'SHLVL': '1', 23:17:13 INFO - 'TERM': 'linux', 23:17:13 INFO - 'TMOUT': '86400', 23:17:13 INFO - 'USER': 'cltbld', 23:17:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:13 INFO - '_': '/tools/buildbot/bin/python'} 23:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:13 INFO - Running setup.py (path:/tmp/pip-5W5jsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:13 INFO - Running setup.py (path:/tmp/pip-2Nm2tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:13 INFO - Running setup.py (path:/tmp/pip-UanD9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:13 INFO - Running setup.py (path:/tmp/pip-CGvqbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:13 INFO - Running setup.py (path:/tmp/pip-FuKayS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:13 INFO - Running setup.py (path:/tmp/pip-xgGdAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:13 INFO - Running setup.py (path:/tmp/pip-mzbwTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:14 INFO - Running setup.py (path:/tmp/pip-r814vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:14 INFO - Running setup.py (path:/tmp/pip-2EGsX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:14 INFO - Running setup.py (path:/tmp/pip-k7I6JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:14 INFO - Running setup.py (path:/tmp/pip-aic6op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:14 INFO - Running setup.py (path:/tmp/pip-qCA3Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:14 INFO - Running setup.py (path:/tmp/pip-2LO0F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:14 INFO - Running setup.py (path:/tmp/pip-COjcdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:14 INFO - Running setup.py (path:/tmp/pip-TZdxvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:14 INFO - Running setup.py (path:/tmp/pip-EFxzKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:14 INFO - Running setup.py (path:/tmp/pip-50K9mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:17:14 INFO - Running setup.py install for manifestparser 23:17:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:17:14 INFO - Running setup.py install for mozcrash 23:17:14 INFO - Running setup.py install for mozdebug 23:17:15 INFO - Running setup.py install for mozdevice 23:17:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for mozfile 23:17:15 INFO - Running setup.py install for mozhttpd 23:17:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for mozinfo 23:17:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for mozInstall 23:17:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for mozleak 23:17:15 INFO - Running setup.py install for mozlog 23:17:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for moznetwork 23:17:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:17:15 INFO - Running setup.py install for mozprocess 23:17:15 INFO - Running setup.py install for mozprofile 23:17:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:17:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:17:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:17:16 INFO - Running setup.py install for mozrunner 23:17:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:17:16 INFO - Running setup.py install for mozscreenshot 23:17:16 INFO - Running setup.py install for moztest 23:17:16 INFO - Running setup.py install for mozversion 23:17:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:17:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:17:16 INFO - Cleaning up... 23:17:16 INFO - Return code: 0 23:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:16 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')]} 23:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:16 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')]} 23:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:16 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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:16 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 23:17:16 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 23:17:16 INFO - Using env: {'DISPLAY': ':0', 23:17:16 INFO - 'HOME': '/home/cltbld', 23:17:16 INFO - 'LANG': 'en_US.UTF-8', 23:17:16 INFO - 'LANGUAGE': 'en_US:en', 23:17:16 INFO - 'LOGNAME': 'cltbld', 23:17:16 INFO - 'MAIL': '/var/mail/cltbld', 23:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:16 INFO - 'MOZ_NO_REMOTE': '1', 23:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:16 INFO - 'NO_EM_RESTART': '1', 23:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:16 INFO - 'PWD': '/builds/slave/test', 23:17:16 INFO - 'SHELL': '/bin/bash', 23:17:16 INFO - 'SHLVL': '1', 23:17:16 INFO - 'TERM': 'linux', 23:17:16 INFO - 'TMOUT': '86400', 23:17:16 INFO - 'USER': 'cltbld', 23:17:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:16 INFO - '_': '/tools/buildbot/bin/python'} 23:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:16 INFO - Running setup.py (path:/tmp/pip-XkC1jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:16 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)) 23:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:16 INFO - Running setup.py (path:/tmp/pip-N8lYW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:16 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)) 23:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:16 INFO - Running setup.py (path:/tmp/pip-M9JfRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:16 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)) 23:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:16 INFO - Running setup.py (path:/tmp/pip-jhpppA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:17 INFO - Running setup.py (path:/tmp/pip-_pcF5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:17 INFO - Running setup.py (path:/tmp/pip-6FqK2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:17 INFO - Running setup.py (path:/tmp/pip-k6RcuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:17 INFO - Running setup.py (path:/tmp/pip-OkZRRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:17 INFO - Running setup.py (path:/tmp/pip-3mBUgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:17 INFO - Running setup.py (path:/tmp/pip-5BThn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:17 INFO - Running setup.py (path:/tmp/pip-5Z0hu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:17 INFO - Running setup.py (path:/tmp/pip-UakCPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:17 INFO - Running setup.py (path:/tmp/pip-WPWyxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:17 INFO - Running setup.py (path:/tmp/pip-aCLp7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:17 INFO - Running setup.py (path:/tmp/pip-DWJBU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:17 INFO - Running setup.py (path:/tmp/pip-IY3HdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:17 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)) 23:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:17 INFO - Running setup.py (path:/tmp/pip-rVOKzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:18 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)) 23:17:18 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)) 23:17:18 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)) 23:17:18 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)) 23:17:18 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)) 23:17:18 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)) 23:17:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:18 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 23:17:18 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 23:17:18 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 23:17:18 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 23:17:18 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 23:17:18 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 23:17:20 INFO - Downloading blessings-1.6.tar.gz 23:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:20 INFO - Installing collected packages: blessings 23:17:20 INFO - Running setup.py install for blessings 23:17:21 INFO - Successfully installed blessings 23:17:21 INFO - Cleaning up... 23:17:21 INFO - Return code: 0 23:17:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:21 INFO - Reading from file tmpfile_stdout 23:17:21 INFO - Current package versions: 23:17:21 INFO - argparse == 1.2.1 23:17:21 INFO - blessings == 1.6 23:17:21 INFO - blobuploader == 1.2.4 23:17:21 INFO - docopt == 0.6.1 23:17:21 INFO - manifestparser == 1.1 23:17:21 INFO - mozInstall == 1.12 23:17:21 INFO - mozcrash == 0.17 23:17:21 INFO - mozdebug == 0.1 23:17:21 INFO - mozdevice == 0.48 23:17:21 INFO - mozfile == 1.2 23:17:21 INFO - mozhttpd == 0.7 23:17:21 INFO - mozinfo == 0.9 23:17:21 INFO - mozleak == 0.1 23:17:21 INFO - mozlog == 3.2 23:17:21 INFO - moznetwork == 0.27 23:17:21 INFO - mozprocess == 0.22 23:17:21 INFO - mozprofile == 0.28 23:17:21 INFO - mozrunner == 6.11 23:17:21 INFO - mozscreenshot == 0.1 23:17:21 INFO - mozsystemmonitor == 0.3 23:17:21 INFO - moztest == 0.7 23:17:21 INFO - mozversion == 1.4 23:17:21 INFO - psutil == 3.1.1 23:17:21 INFO - requests == 1.2.3 23:17:21 INFO - wsgiref == 0.1.2 23:17:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:21 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 23:17:21 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 23:17:21 INFO - Using env: {'DISPLAY': ':0', 23:17:21 INFO - 'HOME': '/home/cltbld', 23:17:21 INFO - 'LANG': 'en_US.UTF-8', 23:17:21 INFO - 'LANGUAGE': 'en_US:en', 23:17:21 INFO - 'LOGNAME': 'cltbld', 23:17:21 INFO - 'MAIL': '/var/mail/cltbld', 23:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:21 INFO - 'MOZ_NO_REMOTE': '1', 23:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:21 INFO - 'NO_EM_RESTART': '1', 23:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:21 INFO - 'PWD': '/builds/slave/test', 23:17:21 INFO - 'SHELL': '/bin/bash', 23:17:21 INFO - 'SHLVL': '1', 23:17:21 INFO - 'TERM': 'linux', 23:17:21 INFO - 'TMOUT': '86400', 23:17:21 INFO - 'USER': 'cltbld', 23:17:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:21 INFO - '_': '/tools/buildbot/bin/python'} 23:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 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)) 23:17:21 INFO - Cleaning up... 23:17:21 INFO - Return code: 0 23:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:21 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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:21 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 23:17:21 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 23:17:21 INFO - Using env: {'DISPLAY': ':0', 23:17:21 INFO - 'HOME': '/home/cltbld', 23:17:21 INFO - 'LANG': 'en_US.UTF-8', 23:17:21 INFO - 'LANGUAGE': 'en_US:en', 23:17:21 INFO - 'LOGNAME': 'cltbld', 23:17:21 INFO - 'MAIL': '/var/mail/cltbld', 23:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:21 INFO - 'MOZ_NO_REMOTE': '1', 23:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:21 INFO - 'NO_EM_RESTART': '1', 23:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:21 INFO - 'PWD': '/builds/slave/test', 23:17:21 INFO - 'SHELL': '/bin/bash', 23:17:21 INFO - 'SHLVL': '1', 23:17:21 INFO - 'TERM': 'linux', 23:17:21 INFO - 'TMOUT': '86400', 23:17:21 INFO - 'USER': 'cltbld', 23:17:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:21 INFO - '_': '/tools/buildbot/bin/python'} 23:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:21 INFO - Downloading/unpacking jsonschema 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:21 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 23:17:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:17:23 INFO - Downloading/unpacking functools32 (from jsonschema) 23:17:23 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 23:17:23 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 23:17:23 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 23:17:23 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 23:17:23 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 23:17:23 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 23:17:23 INFO - Downloading functools32-3.2.3-2.tar.gz 23:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:17:23 INFO - warning: no files found matching '*.txt' 23:17:23 INFO - no previously-included directories found matching 'build' 23:17:23 INFO - no previously-included directories found matching 'dist' 23:17:23 INFO - no previously-included directories found matching '.git*' 23:17:23 INFO - Installing collected packages: jsonschema, functools32 23:17:23 INFO - Running setup.py install for functools32 23:17:24 INFO - warning: no files found matching '*.txt' 23:17:24 INFO - no previously-included directories found matching 'build' 23:17:24 INFO - no previously-included directories found matching 'dist' 23:17:24 INFO - no previously-included directories found matching '.git*' 23:17:24 INFO - Successfully installed jsonschema functools32 23:17:24 INFO - Cleaning up... 23:17:24 INFO - Return code: 0 23:17:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:17:24 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')]} 23:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:24 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')]} 23:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:24 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 0x7f02f30d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, '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': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', '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 23:17:24 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 23:17:24 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 23:17:24 INFO - Using env: {'DISPLAY': ':0', 23:17:24 INFO - 'HOME': '/home/cltbld', 23:17:24 INFO - 'LANG': 'en_US.UTF-8', 23:17:24 INFO - 'LANGUAGE': 'en_US:en', 23:17:24 INFO - 'LOGNAME': 'cltbld', 23:17:24 INFO - 'MAIL': '/var/mail/cltbld', 23:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:24 INFO - 'MOZ_NO_REMOTE': '1', 23:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:24 INFO - 'NO_EM_RESTART': '1', 23:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:24 INFO - 'PWD': '/builds/slave/test', 23:17:24 INFO - 'SHELL': '/bin/bash', 23:17:24 INFO - 'SHLVL': '1', 23:17:24 INFO - 'TERM': 'linux', 23:17:24 INFO - 'TMOUT': '86400', 23:17:24 INFO - 'USER': 'cltbld', 23:17:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:24 INFO - '_': '/tools/buildbot/bin/python'} 23:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:24 INFO - Downloading/unpacking flake8 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:24 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 23:17:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:17:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:17:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 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 23:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:17:26 INFO - no previously-included directories found matching 'docs/_build' 23:17:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:17:27 INFO - Running setup.py install for pep8 23:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:17:27 INFO - no previously-included directories found matching 'docs/_build' 23:17:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:17:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:17:27 INFO - Cleaning up... 23:17:27 INFO - Return code: 0 23:17:27 INFO - Running post-action listener: _resource_record_post_action 23:17:27 INFO - Running post-action listener: _start_resource_monitoring 23:17:27 INFO - Starting resource monitoring. 23:17:27 INFO - ##### 23:17:27 INFO - ##### Finished create-virtualenv step (success) 23:17:27 INFO - ##### 23:17:27 INFO - ##### 23:17:27 INFO - ##### Running install step. 23:17:27 INFO - ##### 23:17:27 INFO - Running pre-action listener: _resource_record_pre_action 23:17:27 INFO - Running main action method: install 23:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:27 INFO - Reading from file tmpfile_stdout 23:17:27 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:27 INFO - Reading from file tmpfile_stdout 23:17:27 INFO - Output received: 23:17:27 INFO - Usage: mozinstall [options] installer 23:17:27 INFO - Options: 23:17:27 INFO - -h, --help show this help message and exit 23:17:27 INFO - -d DEST, --destination=DEST 23:17:27 INFO - Directory to install application into. [default: 23:17:27 INFO - "/builds/slave/test"] 23:17:27 INFO - --app=APP Application being installed. [default: firefox] 23:17:27 INFO - mkdir: /builds/slave/test/build/application 23:17:27 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'] 23:17:27 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 23:17:44 INFO - Reading from file tmpfile_stdout 23:17:44 INFO - Output received: 23:17:44 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:44 INFO - Running post-action listener: _resource_record_post_action 23:17:44 INFO - ##### 23:17:44 INFO - ##### Finished install step (success) 23:17:44 INFO - ##### 23:17:44 INFO - ##### 23:17:44 INFO - ##### Running run-tests step. 23:17:44 INFO - ##### 23:17:44 INFO - Running pre-action listener: _resource_record_pre_action 23:17:44 INFO - Running main action method: run_tests 23:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:44 INFO - Python 2.7.3 23:17:44 INFO - Return code: 0 23:17:44 INFO - grabbing minidump binary from tooltool 23:17: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')]} 23:17:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13009c0>, '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 0x13018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:17:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:17:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:17:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:44 INFO - Return code: 0 23:17:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:17:45 INFO - Return code: 0 23:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 23:17:45 INFO - Using env: {'DISPLAY': ':0', 23:17:45 INFO - 'HOME': '/home/cltbld', 23:17:45 INFO - 'LANG': 'en_US.UTF-8', 23:17:45 INFO - 'LANGUAGE': 'en_US:en', 23:17:45 INFO - 'LOGNAME': 'cltbld', 23:17:45 INFO - 'MAIL': '/var/mail/cltbld', 23:17:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:45 INFO - 'MOZ_NO_REMOTE': '1', 23:17:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:45 INFO - 'NO_EM_RESTART': '1', 23:17:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:45 INFO - 'PWD': '/builds/slave/test', 23:17:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:45 INFO - 'SHELL': '/bin/bash', 23:17:45 INFO - 'SHLVL': '1', 23:17:45 INFO - 'TERM': 'linux', 23:17:45 INFO - 'TMOUT': '86400', 23:17:45 INFO - 'USER': 'cltbld', 23:17:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915', 23:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:45 INFO - '_': '/tools/buildbot/bin/python'} 23:17:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:45 INFO - mozversion application_buildid: 20160515203030 23:17:45 INFO - mozversion application_changeset: 7084bd828e4c688daf6078a710d2f267bb52591a 23:17:45 INFO - mozversion application_display_name: Nightly 23:17:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:45 INFO - mozversion application_name: Firefox 23:17:45 INFO - mozversion application_remotingname: firefox 23:17:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:45 INFO - mozversion application_vendor: Mozilla 23:17:45 INFO - mozversion application_version: 49.0a1 23:17:45 INFO - mozversion platform_buildid: 20160515203030 23:17:45 INFO - mozversion platform_changeset: 7084bd828e4c688daf6078a710d2f267bb52591a 23:17:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:45 INFO - mozversion platform_version: 49.0a1 23:17:45 INFO - using testdate: 1463379465 23:17:45 INFO - actual date: 1463379465 23:17:45 INFO - starting webserver on 'localhost:48056' 23:17:45 INFO - SUITE-START | Running 2 tests 23:17:45 INFO - TEST-START | dromaeo_css 23:17:45 INFO - operating with platform_type : linux_ 23:17:45 INFO - Initialising browser for dromaeo_css test... 23:17:45 INFO - TEST-INFO | started process 9045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp79d4NX/profile http://localhost:48056/getInfo.html) 23:17:49 INFO - PROCESS | 9045 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:17:49 INFO - PROCESS | 9045 | 23:17:49 INFO - PROCESS | 9045 | (process:9113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:17:50 INFO - PROCESS | 9045 | __metrics Screen width/height:1600/1200 23:17:50 INFO - PROCESS | 9045 | colorDepth:24 23:17:50 INFO - PROCESS | 9045 | Browser inner width/height: 1024/697 23:17:50 INFO - PROCESS | 9045 | __metrics 23:17:51 ERROR - PROCESS | 9045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:17:52 INFO - TEST-INFO | 9045: exit 0 23:17:52 INFO - Browser initialized. 23:17:52 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:52 INFO - TEST-INFO | started process 9164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp79d4NX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:54 INFO - PROCESS | 9164 | 23:17:54 INFO - PROCESS | 9164 | (process:9225): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:18:04 INFO - PROCESS | 9164 | RSS: Main: 163590144 23:18:04 INFO - PROCESS | 9164 | 23:18:53 INFO - PROCESS | 9164 | 1463379533656 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] 23:21:01 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48056/tests/dromaeo/cssquery-ext.html) 23:21:02 INFO - PROCESS | 9164 | RSS: Main: 167575552 23:21:02 INFO - PROCESS | 9164 | 23:24:04 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-ext.html (next: http://localhost:48056/tests/dromaeo/cssquery-jquery.html) 23:24:05 INFO - PROCESS | 9164 | RSS: Main: 166920192 23:24:05 INFO - PROCESS | 9164 | 23:27:07 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48056/tests/dromaeo/cssquery-mootools.html) 23:27:07 INFO - PROCESS | 9164 | RSS: Main: 168112128 23:27:07 INFO - PROCESS | 9164 | 23:30:09 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48056/tests/dromaeo/cssquery-prototype.html) 23:30:09 INFO - PROCESS | 9164 | RSS: Main: 165777408 23:30:09 INFO - PROCESS | 9164 | 23:33:12 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48056/tests/dromaeo/cssquery-yui.html) 23:33:13 INFO - PROCESS | 9164 | RSS: Main: 166879232 23:33:13 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | Cycle 1(1): loaded http://localhost:48056/tests/dromaeo/cssquery-yui.html (next: http://localhost:48056/tests/dromaeo/cssquery-dojo.html) 23:36:15 INFO - PROCESS | 9164 | RSS: Main: 169582592 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | __start_tp_report 23:36:15 INFO - PROCESS | 9164 | _x_x_mozilla_page_load 23:36:15 INFO - PROCESS | 9164 | _x_x_mozilla_page_load_details 23:36:15 INFO - PROCESS | 9164 | |i|pagename|runs| 23:36:15 INFO - PROCESS | 9164 | |0;dojo.html;3142.214446388403;3150.810951342918;3181.650018497965;3193.2815116598767;3203.2152122729935;5259.500347466994;5342.1452567589195;5351.759170837312;5353.652012619177;5404.83785486436;5296.232046353276;5348.572114230862;5352.705601191943;5427.511523962842;5428.185772134182;4875;4909.067277217335;5029.497050294959;5045.747712614373;5093.752030752471;744.3852277456339;4930.28510865926;4955.653104282702;4958.752062396884;5006.374203224597;4938.629602779806;4946.653734238605;4968.726720030397;4969.35398398206;5026.29631851541;4793.448753393334;4997.800087996476;5004.774785134678;5024.949750502485;5056.873578160538;4773.546513081252;4814.927776083362;4819.855404337875;4835.782389792468;4859.805607775685;5157.974210128963;5283.498067683564;5283.788648454057;5288.68267903927;5344.225087362311;5669.348024977098;5707.6290041147195;5745.253117094751;5746.683932383718;5748.109043098327;5760.9918264304;5798.10129429939;5830.446107619811;5830.5044071254;5873.735681894325;5373.973130134364;5409.0534156522845;5421.891562168735;5424.647397919122;5429.918551221735;5675.489205971482;5826.621269617462;5872.941270587325;5890.293164820249;5909.23179986599;5726.79956201531;5747.626404283708;5749.252597162425;5753.252077229933;5756.42435756421;5815.040518314515;5818.650880947157;5821.243238379068;5828.766849326064;5829.59192856496;5579.246801681802;5682.659040457585;5722.113072473773;5739;5755.395683453261;5567.415421380778;5683.374828768832;5757.712114394263;5775.16260142277;5833.38749431312;4354.99835037943;4368.737875727466;4371.606555409965;4387.4954380246045;4409.11817636474;3878.3600705883214;3907.3748200288387;3924.6664033557468;3941.2511622792154;3980.1840622672285;5508.338999320107;5594.1608758686525;5607.327120745536;5611.887762244733;5615.410381909923;5809.215755872903;5880.470757631833;5908.881822363529;5911.024680927685;5952.136940143655;5422.945770542244;5481.945180548143;5487.259220005328;5509.00837849183;5531.668099914018;4965.90068198634;4967;4997.325361076281;5005.474425185376;5028.899422011539;5862.443067908627;6023.036314189709;6034.306054803666;6043.939560604338;6051.062085376773;5752.884942301214;5760.135979603093;5776.220210271559;5864.882702345843;5875.236219291465;6018.277806663228;6027.035674292092;6031.668258245839;6053.697315134314;6066.181065556093;5586.301712285965;5634.211210430461;5679.630823996592;5690.3456102548735;5700.629459085146;5784.2769653793275;5796.42035796417;5798.10129429939;5806.82579522615;5820.854478638068;5693.345265294544;5702.743376548148;5704.714764261853;5711.857203569944;5726.341470730753;5539.750711217925;5628.774849006158;5663.546916246608;5669.744861481161;5698.487136157766;5431.429699881455;5438.945610544002;5446.591505637014;5503.036968530411;5670.631408958405;5615.971920140373;5655.943440565542;5662.971685141548;5676.914846277226;5680.233168522197;5405.864853378697;5475.397706252229;5499.725013749377;5567.582431317748;5569.248151499496 23:36:15 INFO - PROCESS | 9164 | |1;ext.html;602.5691630484203;645.2225068792106;646.5248042688626;649.0945131541497;664.8902931016381;42309.78845105774;43361.56638433615;43617;46343.841403964834;47457.2034237261;44583;44739.328910066375;45119;45198.32202516965;45247.77376113123;8886.77783055424;9040.321975851804;9056.683016094437;9093.40892841963;9095.863562046574;8888.333374996868;8992.100789921022;9000.324975626821;9006.189442950134;9009.099090091004;8955.328350373715;8981.416207946462;8982.820343593125;9004.954975225115;9025.59384827681;8948.463092214455;8979.820403591892;8981.910180898205;8985;8990.910090899073;8861.113888611088;8946.060663630291;8966.730998070068;8974.461532308082;8987.281017518582;42415.57584424147;42851.785741071406;43050.35424468636;43151;43311.783441082596;3251.7723759336855;3460.1349662584353;3486.3682999471944;3511.5434993450945;3517.278957813642;33133.502997455056;33201.833990830135;33467.832660836786;34818.47772283418;34864.82567587171;4273.893152671208;4295.763732994684;4348.608625223745;4380.956190438087;4417.337399390085;370948;372057;372068;373014.1349293263;374021;34883;59242.70378648079;59618.317175726326;59757;59772.10341844876;35716;37774.62225377766;37786.43320350197;37918;38122.809385952896;13962.301884905713;14131.081479703786;14171.370292416297;14225.07537010091;14265.64335891611;11721.4139293035;11732.648020559396;11733.237339573072;11765.941170294265;11833.053355731521;8559.315254779603;8631.611577479029;8633.395662303705;8665.740027799176;8738.86891696625;3300.818454984999;3341.365140623274;3345.6654334566347;3353.9329213415594;3384.356972175328;978.6868202175235;1033.4449493741654;1043.9164866810636;1043.95824167034;1176.4823477669797;31386.843065784982;32410.027699169063;32424.83787581047;32608.347833043208;32792.34415311681;1145.169751929861;1206.3546002888588;1217.4278089298016;1241.74043136766;1296.941637626309;17179.141042947802;17255.22351494186;17323.82676173222;17351.219195136247;17557.736633950502;570466;572253;574414;574527;576870;59774;60624.69687651622;60814.74296799181;60887;61049.69475152596;1381.8203633527578;1406.6202125426078;1415.7380884536394;1416.5750274917484;1439.1509009684337;32335;32593.34813303768;32682.50976235406;32864.342713145124;33244.667553325125;51391.48608513867;51827.481725183774;51846.48153518417;52017;52311;499971;500346;503838;504104;504202;27924;28259.293517662223;28514.287142821595;28621.427571448872;28795.424091517634;48691;48846;49053.509464906325;49444;49590.25614615712;41629.79185104055;41649;42145.578544214164;42813.57186428096;43187;40990;41632.583674162874;41998.79000604978;42490.57509424866;42626.57373426226;36094.8195259022;41765.37351939663;43686.344704828814;43947.34078988754;44889;35664.465033024004;37015.25969480649;37561.4365784508;38993.220135597694;39562;29234.7076529232;29270.26824329409;29773.702262977095;29883.55174672338;30174 23:36:15 INFO - PROCESS | 9164 | |2;jquery.html;396.6073587148722;399.82207917476734;401.3417994489038;402.42051445917883;420.0779289459637;15276.465323713672;18422.078896055194;19842.206311747548;19882.20471181153;19925.402237932885;18511.16699748511;18739;19300.324488642902;19428.708569371473;19492.902535487337;5481.972590137054;5591.916121258185;5659.575531835108;5667.801626943058;5678.034734095214;5476.58925580581;5623;5624.465675760816;5628.268325117729;5632.859178520549;5391.81128660497;5601.439856014386;5609.102543593026;5643.887122257553;5663.603547751659;5539.41836107209;5585.720713964326;5623.437656234385;5629.380768115504;5640.464155905223;4859.708417494961;4943.579795717368;4946.950530494685;4986.202207646796;4994.625403094782;22325.43257525389;22337.218197363014;22984.195553155725;23307.3007809766;23467.647985280233;2186.9562608747897;2303.896324665394;2367.5501654685554;2369.609014512603;2429.817763667714;9422.104900034554;9428.198603118743;9594.992525784763;9640.373375730625;9933.453660048694;1915.7413749143966;1940.6596457825146;1941.7864034956144;1988.4929343017438;2053.8254248388903;80165.19834801636;80910.59544702298;82468.58765706193;82923.5853820727;83192.16807831965;9477.857832132524;9978.600855965826;10729.78540429187;10990.560377584807;11039.72400689973;11247;11878.762424751629;12049.638510844688;14959;15046.849531504764;7320.048393708784;7433.331000209899;7435.1449583297535;7505.4746167767735;7628.580428076509;7450.180480147288;7746.341560967381;7759.185285544936;7843.294103530709;7900.130985591581;3773.3019391412126;3807.58116607173;3815.3323168445413;3826.445165450994;3843.2121415109837;1812.918418671163;1828.652556014353;1829.8719089663596;1834.055461437361;1856.4059500959834;409.9877003689894;424.6602717825727;1021.1932573267185;1036.445332001997;1061.1722856172198;10885.782284354269;11428;11461.885381146249;11509.424528773528;11594.420278986017;427.54466493184657;441.942547468827;442.4469413233458;463.0992719161199;960.4237457525429;10154.898451015542;10813.62152324665;10857.51141198648;10889.509972051277;10935.83596246057;449916;453496;454696;468087;483762;93608;93948;94503;95059;96538.51730741301;910.854263317866;917.7063339731222;925.0333401595349;927.730958022166;928.5032507608532;16992.150392480573;17045;17059.317627294768;17338.826611733723;17354.652906941537;37960;38288.80855595704;39133.60866391299;39169.804150979064;39350;56892.71553642205;57036;57646;57701.13448298195;58190.709046454496;7747.535147891144;7754.651040703069;8387.874181887399;8519.361047921308;8536.871946920677;12831;12998.220106793622;13150.27673477968;13345.332733363099;13358.866411335763;11622.593209237637;11791.823122652995;11869.287842729464;12161.574344897886;12196.81704774447;11627;11774.411279436164;11781.057515398576;11815.232009919328;11945.581904633296;12128.514859405524;12244.265344079384;12277.20198187115;12363;12480.75038499243;7632.885506717293;7724.304812566896;7733;7777.805554860947;8207.466514676527;11939.223950443193;11952.76094478088;12059.457324420599;12078.21491603043;12080.697982550506 23:36:15 INFO - PROCESS | 9164 | |3;mootools.html;1500.3173556032007;1522.7182971150337;1709.4187976088128;1822.690142675745;1840.411068458094;8046.235607617282;8621.224089831914;8711;9070.002299747031;9163.816723665523;8759.343049271314;9031.54842257886;9038.322125840572;9067;9083.046280140588;2080.5838832233576;2097.674860396641;2105.7788932162134;2108.1356643776053;2109.198504568262;2079.6984437256588;2100.12844669462;2118.608057509358;2124.076026928291;2126.5215326551556;2076.7923207679187;2080.0327847550884;2087.6764101564204;2090.4982804127053;2135.9145634174615;2059.320424259998;2077.9168833246654;2079.189116244666;2081.687746837971;2081.7918208179212;2059.5983783162287;2066.1941842681367;2074.4295318787304;2084.593504266669;2085.6141613801497;8927.910720892838;9120.680776172801;9123.908760912373;9131.726048218565;9142.085791420872;5062;5128.307678463397;5153.2785410042625;5168.483151684802;5191.221316802472;3285.342931413703;3291.0949488890506;3346.7991920484606;3371.8819841305435;3399.5240666306736;1101.4878081691973;1141.2809929744292;1141.4349896801054;1152.8962393384636;1186.9643910682694;12608.936955315348;12720.87279127206;12733.236005839679;12749.17130386522;12774.233545987177;4387.341898715218;4437.644988400984;4516.299973504112;4544.295634176708;4575.611073058827;10679.19906007037;10682.679519614425;10699.518521666543;10705.411202383788;10706.25056246071;5261.421243663194;5286.7356632169;5292.92060619091;5295.443978382292;5304.734763261821;4324.675649326313;4555.2711566149255;4666.883327916829;4721.551452611996;4838.758062096881;3940.2119576084897;3940.2513522430645;4015.1166743316426;4045.8179381927885;4101.692373072032;1179.929204247748;1220.4934951995;1227.4353797253184;1236.4312416288608;1240.3116270469795;941.3692825806726;1011.549860312154;1030.567161792049;1039.26212389203;1050.207093644309;6278.717457714414;6290.55966082379;6337.96831015842;6395;6403.935960640427;408.45675251914884;408.9386592011222;410.12643070260157;411.8929078439567;1059.210887888528;4290.978545107255;4425;4463.486699029653;4487.41663583732;4498.797554110008;11122.721931951604;11384.772304553862;11403.486843092081;11416.885831141748;11429.257098288585;10635.042846143884;11218.326900386002;11295.887041129483;11308.717282068013;11376.260543064674;8171.7548473545885;8443.57782110892;8482.957585212034;8542.10307917672;8557.10150434208;6276.968615157078;6383;6509.73961041572;6529.836754081186;6587.242467116343;10447.373157610567;10531.05220530156;10533;10578.947105264424;10638.73403164927;10068.144207742424;10324.22568307395;10381.117605003357;10431.843522347019;10638.73403164927;7875.369970402468;8315.584220788814;8336.708215212439;8611.95694021526;8666.956665216634;8222.753317400488;8250.133735957877;8271.62777674994;8338.332933365195;8339.20777526134;7408.814779630552;7592.164861865301;7715.267049630276;7723.189065148079;7820.882686759817;7617.200193979553;7698.692052317844;7746.380289576933;7765.72819951299;7870.881936770838;7129.679164437716;7187.820304492429;7192.244814294633;7198.316159964795;7220.855582888208;5302.787888484418;5595.916061259003;5660.915086273627;5663.405342438985;5751.48236658686;5554.722263886871;5598.776048957996;5655.547556195412;5674.148877668383;5741.712914354349 23:36:15 INFO - PROCESS | 9164 | |4;prototype.html;297.9955300670489;309.5372418234739;312.67950350890334;316.2157848535633;317.68549136355;5502.9174562381595;5538.972305138469;5647.717614119293;5737.598368114233;5787.623804452713;5596.2165296858475;5598.86002849929;5601.327840659126;5621.409751976034;5628.549716022719;4214.702986872155;4278.358246263055;4290.6138447539715;4302.935455968147;4334.436523251973;4065.6544193743566;4199.706020578561;4219.303814870543;4352.52122266552;4362.781860906958;4164;4170.039272116801;4209.800206941022;4237.364395340693;4272.444582204324;4264.677949835545;4271.530131685512;4299.613034826849;4309.396684464177;4319.460067491564;3544.680978711928;3710;3711.981440092782;3722.497462842509;3733.7199710021855;5432.75552600134;5435.673859568399;5452.2094296327205;5452.491853747281;5469.671819690831;4847.673116903906;4910.803567857281;4925.532074452921;4929.285253638202;4931.950680493221;5606.6636001840025;5841.824745257649;5847;5875.38308477608;5875.882482350372;4069.104796944667;4085.5301640311445;4099.1596722672075;4109.815058322382;4121.9381709274385;6125.448709616111;6195.933013158516;6215.254169499689;6222.439980401786;6241.28225254097;4024.8993775155855;4164.12553363797;4169.353750168729;4169.874903752892;4183.790810459464;4190.832366705358;4197.160567886435;4198.748075115503;4210.957890421118;4225.176090662291;4881.219004959261;4904.950950490521;4921.704697718148;4948.084604348207;4955.256711493233;5851.678157701367;5906.675132867734;5918.674472903946;5953.732082056231;5980.820575382745;1435.727211829749;1457.227669335254;1462.5319897632655;1469.8015767871414;1479.5413421839048;870.5299138465284;906.3610154840821;912.7449756584696;923.2936803345447;931.2410385535767;5048.217526283432;5093.516115968977;5129.410117836496;5153.381594208644;5176.06830770465;5367.731613419313;5410.08028635133;5423.755930983115;5452.49185374732;5455.754491047913;4897.4817806480105;4991.831820429909;5113.360829896263;5193.714345710947;5197.908439227729;2912.3592809582283;2919.3431477917297;2929.9745089219027;2938.882444702188;2941.426421847719;5528.889422211533;5562.666240025531;5579.553635709133;5585.860353491195;5613.803516876971;5461.5357694596405;5732.828015159552;6187.597806142587;6212.47193988516;6288.8427789304715;6286.717097730613;6372.36276372359;6406.391392817675;6431.260405053479;6455.225372955181;5953.851153721192;6115.541334400027;6134.938650613437;6136.417040381157;6138.416850399205;6026.323942395048;6041.214642096499;6059.3334733178435;6069.514438844793;6073.5748497604745;5763.5965482417505;6332.715027823667;6359.96820015897;6392.9360706392345;6406.295307516077;4106.917861642691;4174.624283814472;4193.840172311201;4197.433346498184;4225.57744225575;6033.5173186145885;6081.996470582304;6119.510439164945;6134.539909506894;6183.783567575113;5701.201268032706;5895.616784908967;5915.467607915309;5934.6350339421315;5937.643741375531;5850.1626711044255;5878.529717622666;5899.348182508905;5900.616459930091;5902.085176797603;5798.652080875161;5805.767769289181;5833.141760537391;5848.444397782204;5863.677497737665;5686.2323586315315;6004.519638429003;6069.241344831896;6080.7567697291615;6089.177960975212;5830.737616807169;5832.104566015977;5883.999440190356;5892.558058145742;5909.202257695156 23:36:15 INFO - PROCESS | 9164 | |5;yui.html;794.6702118620773;804.3002587748656;843.7257891185365;881.8544940084886;898.460923445933;14401.927990360047;14545.709085818304;14649.04781189222;14668.853311466883;14685.265736713174;12119.333436661002;13661.316934153278;13705.314734263296;13707.109037912554;13708.314584270796;810.8783682447621;839.0183485322157;839.1147339556795;839.8992120945464;841.4194205997842;840.8822764812932;841.146236569882;841.8905542279496;848.3510114762212;849.9405041647087;890.6838072484272;890.812929284851;891.7636826241052;893.9016708162129;894.3292530602048;877.3814460805118;882.4925667741043;883.9823203535925;885.2298500304776;888.7333799860016;632.9398707122816;637.8022812928007;638.2181827261613;638.9520785941027;640.4812102197235;14162.433502659882;14189.290535473288;14214.147151170859;14241.145531268054;14254.92872535641;13917.443302267999;13961.930190349085;14161.29193540319;14243.928780356031;14251.287435628281;12739.299338536377;12859;13003.349832508336;13006.609801705965;13066.934665326613;4622.745748983804;4651.209294419957;4660.231061874787;4675.111728771557;4731.124741922721;60755.39244607541;60771.39228607702;61246.69376653133;61424.07863882045;61579;11340.432978351215;11351;11510.654680359603;11536.25014374063;11914.761704765857;20615.38153855387;20916.267930622354;20935.476613084797;20980;20988.790112098683;8685.869711954325;8760.693375731818;8942.821143577223;9062.592183351764;9097.954510227406;4713.552212539872;4797.280407938767;4807.831725889577;4864.051509955595;4935.851924442272;3508.386032444312;3580.0870777951454;3589.533360663097;3598.9280214395567;3613.602503724588;671.332024635481;684.9794506164823;695.6938946863465;702.3503259484957;707.2255879811598;762.1768490030864;762.4091329219899;772.8956590860274;783.8314762326128;786.7679034684782;9253.259739220981;9727.9027209727;10019.098281154731;10038.799224015625;10071.24465665078;758.0940775772898;773.5474747272908;775.5308038636656;777.5179388778993;790.9011373578303;4596.4024676791805;4613.2388155953895;4755.096531658974;4759.286107083965;4768.523147685204;63972.562332201356;65478;71021;71699.28300716926;71782.28217717861;56053.43946560564;58527.12209316863;61809.69095154495;62297;70622;57283.713581431824;59552.404475955555;60352.698236508535;60799.69600151971;60973.39026609677;9514.762130946781;9818.558164882455;9828.606855725691;9833.360831545926;9940;38373.61626383701;38380.80809595934;38453.80773096117;38714.80642596769;38801.6119838798;47940;52777;53564.46435535595;54203.18695219496;54554.181687275515;12721.745565088831;13080.672983175116;13112.475500979854;13227.735445291233;13496.32518374097;14171.787423188867;14595.92702036483;15198.46805361807;15555.76666349983;15576.766348505009;13938.651533711738;14005.299735013004;14214.786778198542;14333.64165895861;15006.399744010554;12800.487980480677;12872;12893.93553032229;13003.609891703263;13174.802377964146;13364.799528007283;13399.397027133997;13548.254845983565;13627.182369057888;14476;10217.438040907822;10799.460026998462;11086.778264434504;11108.390262917499;11282.830757538808;10951.890481095086;11940;11941.46263418131;12078.21491603043;12204.511819527119 23:36:15 INFO - PROCESS | 9164 | __end_tp_report 23:36:15 INFO - PROCESS | 9164 | __start_cc_report 23:36:15 INFO - PROCESS | 9164 | _x_x_mozilla_cycle_collect,348 23:36:15 INFO - PROCESS | 9164 | __end_cc_report 23:36:15 INFO - PROCESS | 9164 | __startTimestamp1463380575723__endTimestamp 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | ------- Summary: start ------- 23:36:15 INFO - PROCESS | 9164 | Number of tests: 6 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#0] dojo.html Cycles:165 Average:5345.21 Median:5586.30 stddev:705.91 (12.6%) stddev-sans-first:686.59 23:36:15 INFO - PROCESS | 9164 | Values: 3142.2 3150.8 3181.7 3193.3 3203.2 5259.5 5342.1 5351.8 5353.7 5404.8 5296.2 5348.6 5352.7 5427.5 5428.2 4875.0 4909.1 5029.5 5045.7 5093.8 744.4 4930.3 4955.7 4958.8 5006.4 4938.6 4946.7 4968.7 4969.4 5026.3 4793.4 4997.8 5004.8 5024.9 5056.9 4773.5 4814.9 4819.9 4835.8 4859.8 5158.0 5283.5 5283.8 5288.7 5344.2 5669.3 5707.6 5745.3 5746.7 5748.1 5761.0 5798.1 5830.4 5830.5 5873.7 5374.0 5409.1 5421.9 5424.6 5429.9 5675.5 5826.6 5872.9 5890.3 5909.2 5726.8 5747.6 5749.3 5753.3 5756.4 5815.0 5818.7 5821.2 5828.8 5829.6 5579.2 5682.7 5722.1 5739.0 5755.4 5567.4 5683.4 5757.7 5775.2 5833.4 4355.0 4368.7 4371.6 4387.5 4409.1 3878.4 3907.4 3924.7 3941.3 3980.2 5508.3 5594.2 5607.3 5611.9 5615.4 5809.2 5880.5 5908.9 5911.0 5952.1 5422.9 5481.9 5487.3 5509.0 5531.7 4965.9 4967.0 4997.3 5005.5 5028.9 5862.4 6023.0 6034.3 6043.9 6051.1 5752.9 5760.1 5776.2 5864.9 5875.2 6018.3 6027.0 6031.7 6053.7 6066.2 5586.3 5634.2 5679.6 5690.3 5700.6 5784.3 5796.4 5798.1 5806.8 5820.9 5693.3 5702.7 5704.7 5711.9 5726.3 5539.8 5628.8 5663.5 5669.7 5698.5 5431.4 5438.9 5446.6 5503.0 5670.6 5616.0 5655.9 5663.0 5676.9 5680.2 5405.9 5475.4 5499.7 5567.6 5569.2 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#1] ext.html Cycles:180 Average:63009.10 Median:42558.57 stddev:130472.75 (306.6%) stddev-sans-first:130754.62 23:36:15 INFO - PROCESS | 9164 | Values: 602.6 645.2 646.5 649.1 664.9 42309.8 43361.6 43617.0 46343.8 47457.2 44583.0 44739.3 45119.0 45198.3 45247.8 8886.8 9040.3 9056.7 9093.4 9095.9 8888.3 8992.1 9000.3 9006.2 9009.1 8955.3 8981.4 8982.8 9005.0 9025.6 8948.5 8979.8 8981.9 8985.0 8990.9 8861.1 8946.1 8966.7 8974.5 8987.3 42415.6 42851.8 43050.4 43151.0 43311.8 3251.8 3460.1 3486.4 3511.5 3517.3 33133.5 33201.8 33467.8 34818.5 34864.8 4273.9 4295.8 4348.6 4381.0 4417.3 370948.0 372057.0 372068.0 373014.1 374021.0 34883.0 59242.7 59618.3 59757.0 59772.1 35716.0 37774.6 37786.4 37918.0 38122.8 13962.3 14131.1 14171.4 14225.1 14265.6 11721.4 11732.6 11733.2 11765.9 11833.1 8559.3 8631.6 8633.4 8665.7 8738.9 3300.8 3341.4 3345.7 3353.9 3384.4 978.7 1033.4 1043.9 1044.0 1176.5 31386.8 32410.0 32424.8 32608.3 32792.3 1145.2 1206.4 1217.4 1241.7 1296.9 17179.1 17255.2 17323.8 17351.2 17557.7 570466.0 572253.0 574414.0 574527.0 576870.0 59774.0 60624.7 60814.7 60887.0 61049.7 1381.8 1406.6 1415.7 1416.6 1439.2 32335.0 32593.3 32682.5 32864.3 33244.7 51391.5 51827.5 51846.5 52017.0 52311.0 499971.0 500346.0 503838.0 504104.0 504202.0 27924.0 28259.3 28514.3 28621.4 28795.4 48691.0 48846.0 49053.5 49444.0 49590.3 41629.8 41649.0 42145.6 42813.6 43187.0 40990.0 41632.6 41998.8 42490.6 42626.6 36094.8 41765.4 43686.3 43947.3 44889.0 35664.5 37015.3 37561.4 38993.2 39562.0 29234.7 29270.3 29773.7 29883.6 30174.0 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#2] jquery.html Cycles:180 Average:27785.04 Median:19873.30 stddev:76521.12 (385.0%) stddev-sans-first:76708.15 23:36:15 INFO - PROCESS | 9164 | Values: 396.6 399.8 401.3 402.4 420.1 15276.5 18422.1 19842.2 19882.2 19925.4 18511.2 18739.0 19300.3 19428.7 19492.9 5482.0 5591.9 5659.6 5667.8 5678.0 5476.6 5623.0 5624.5 5628.3 5632.9 5391.8 5601.4 5609.1 5643.9 5663.6 5539.4 5585.7 5623.4 5629.4 5640.5 4859.7 4943.6 4947.0 4986.2 4994.6 22325.4 22337.2 22984.2 23307.3 23467.6 2187.0 2303.9 2367.6 2369.6 2429.8 9422.1 9428.2 9595.0 9640.4 9933.5 1915.7 1940.7 1941.8 1988.5 2053.8 80165.2 80910.6 82468.6 82923.6 83192.2 9477.9 9978.6 10729.8 10990.6 11039.7 11247.0 11878.8 12049.6 14959.0 15046.8 7320.0 7433.3 7435.1 7505.5 7628.6 7450.2 7746.3 7759.2 7843.3 7900.1 3773.3 3807.6 3815.3 3826.4 3843.2 1812.9 1828.7 1829.9 1834.1 1856.4 410.0 424.7 1021.2 1036.4 1061.2 10885.8 11428.0 11461.9 11509.4 11594.4 427.5 441.9 442.4 463.1 960.4 10154.9 10813.6 10857.5 10889.5 10935.8 449916.0 453496.0 454696.0 468087.0 483762.0 93608.0 93948.0 94503.0 95059.0 96538.5 910.9 917.7 925.0 927.7 928.5 16992.2 17045.0 17059.3 17338.8 17354.7 37960.0 38288.8 39133.6 39169.8 39350.0 56892.7 57036.0 57646.0 57701.1 58190.7 7747.5 7754.7 8387.9 8519.4 8536.9 12831.0 12998.2 13150.3 13345.3 13358.9 11622.6 11791.8 11869.3 12161.6 12196.8 11627.0 11774.4 11781.1 11815.2 11945.6 12128.5 12244.3 12277.2 12363.0 12480.8 7632.9 7724.3 7733.0 7777.8 8207.5 11939.2 11952.8 12059.5 12078.2 12080.7 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#3] mootools.html Cycles:180 Average:5909.18 Median:4356.01 stddev:3458.05 (79.4%) stddev-sans-first:3451.88 23:36:15 INFO - PROCESS | 9164 | Values: 1500.3 1522.7 1709.4 1822.7 1840.4 8046.2 8621.2 8711.0 9070.0 9163.8 8759.3 9031.5 9038.3 9067.0 9083.0 2080.6 2097.7 2105.8 2108.1 2109.2 2079.7 2100.1 2118.6 2124.1 2126.5 2076.8 2080.0 2087.7 2090.5 2135.9 2059.3 2077.9 2079.2 2081.7 2081.8 2059.6 2066.2 2074.4 2084.6 2085.6 8927.9 9120.7 9123.9 9131.7 9142.1 5062.0 5128.3 5153.3 5168.5 5191.2 3285.3 3291.1 3346.8 3371.9 3399.5 1101.5 1141.3 1141.4 1152.9 1187.0 12608.9 12720.9 12733.2 12749.2 12774.2 4387.3 4437.6 4516.3 4544.3 4575.6 10679.2 10682.7 10699.5 10705.4 10706.3 5261.4 5286.7 5292.9 5295.4 5304.7 4324.7 4555.3 4666.9 4721.6 4838.8 3940.2 3940.3 4015.1 4045.8 4101.7 1179.9 1220.5 1227.4 1236.4 1240.3 941.4 1011.5 1030.6 1039.3 1050.2 6278.7 6290.6 6338.0 6395.0 6403.9 408.5 408.9 410.1 411.9 1059.2 4291.0 4425.0 4463.5 4487.4 4498.8 11122.7 11384.8 11403.5 11416.9 11429.3 10635.0 11218.3 11295.9 11308.7 11376.3 8171.8 8443.6 8483.0 8542.1 8557.1 6277.0 6383.0 6509.7 6529.8 6587.2 10447.4 10531.1 10533.0 10578.9 10638.7 10068.1 10324.2 10381.1 10431.8 10638.7 7875.4 8315.6 8336.7 8612.0 8667.0 8222.8 8250.1 8271.6 8338.3 8339.2 7408.8 7592.2 7715.3 7723.2 7820.9 7617.2 7698.7 7746.4 7765.7 7870.9 7129.7 7187.8 7192.2 7198.3 7220.9 5302.8 5595.9 5660.9 5663.4 5751.5 5554.7 5598.8 5655.5 5674.1 5741.7 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#4] prototype.html Cycles:180 Average:4859.21 Median:5486.29 stddev:1479.41 (27.0%) stddev-sans-first:1443.41 23:36:15 INFO - PROCESS | 9164 | Values: 298.0 309.5 312.7 316.2 317.7 5502.9 5539.0 5647.7 5737.6 5787.6 5596.2 5598.9 5601.3 5621.4 5628.5 4214.7 4278.4 4290.6 4302.9 4334.4 4065.7 4199.7 4219.3 4352.5 4362.8 4164.0 4170.0 4209.8 4237.4 4272.4 4264.7 4271.5 4299.6 4309.4 4319.5 3544.7 3710.0 3712.0 3722.5 3733.7 5432.8 5435.7 5452.2 5452.5 5469.7 4847.7 4910.8 4925.5 4929.3 4932.0 5606.7 5841.8 5847.0 5875.4 5875.9 4069.1 4085.5 4099.2 4109.8 4121.9 6125.4 6195.9 6215.3 6222.4 6241.3 4024.9 4164.1 4169.4 4169.9 4183.8 4190.8 4197.2 4198.7 4211.0 4225.2 4881.2 4905.0 4921.7 4948.1 4955.3 5851.7 5906.7 5918.7 5953.7 5980.8 1435.7 1457.2 1462.5 1469.8 1479.5 870.5 906.4 912.7 923.3 931.2 5048.2 5093.5 5129.4 5153.4 5176.1 5367.7 5410.1 5423.8 5452.5 5455.8 4897.5 4991.8 5113.4 5193.7 5197.9 2912.4 2919.3 2930.0 2938.9 2941.4 5528.9 5562.7 5579.6 5585.9 5613.8 5461.5 5732.8 6187.6 6212.5 6288.8 6286.7 6372.4 6406.4 6431.3 6455.2 5953.9 6115.5 6134.9 6136.4 6138.4 6026.3 6041.2 6059.3 6069.5 6073.6 5763.6 6332.7 6360.0 6392.9 6406.3 4106.9 4174.6 4193.8 4197.4 4225.6 6033.5 6082.0 6119.5 6134.5 6183.8 5701.2 5895.6 5915.5 5934.6 5937.6 5850.2 5878.5 5899.3 5900.6 5902.1 5798.7 5805.8 5833.1 5848.4 5863.7 5686.2 6004.5 6069.2 6080.8 6089.2 5830.7 5832.1 5884.0 5892.6 5909.2 23:36:15 INFO - PROCESS | 9164 | 23:36:15 INFO - PROCESS | 9164 | [#5] yui.html Cycles:180 Average:16379.51 Median:4743.11 stddev:19502.84 (411.2%) stddev-sans-first:19522.43 23:36:15 INFO - PROCESS | 9164 | Values: 794.7 804.3 843.7 881.9 898.5 14401.9 14545.7 14649.0 14668.9 14685.3 12119.3 13661.3 13705.3 13707.1 13708.3 810.9 839.0 839.1 839.9 841.4 840.9 841.1 841.9 848.4 849.9 890.7 890.8 891.8 893.9 894.3 877.4 882.5 884.0 885.2 888.7 632.9 637.8 638.2 639.0 640.5 14162.4 14189.3 14214.1 14241.1 14254.9 13917.4 13961.9 14161.3 14243.9 14251.3 12739.3 12859.0 13003.3 13006.6 13066.9 4622.7 4651.2 4660.2 4675.1 4731.1 60755.4 60771.4 61246.7 61424.1 61579.0 11340.4 11351.0 11510.7 11536.3 11914.8 20615.4 20916.3 20935.5 20980.0 20988.8 8685.9 8760.7 8942.8 9062.6 9098.0 4713.6 4797.3 4807.8 4864.1 4935.9 3508.4 3580.1 3589.5 3598.9 3613.6 671.3 685.0 695.7 702.4 707.2 762.2 762.4 772.9 783.8 786.8 9253.3 9727.9 10019.1 10038.8 10071.2 758.1 773.5 775.5 777.5 790.9 4596.4 4613.2 4755.1 4759.3 4768.5 63972.6 65478.0 71021.0 71699.3 71782.3 56053.4 58527.1 61809.7 62297.0 70622.0 57283.7 59552.4 60352.7 60799.7 60973.4 9514.8 9818.6 9828.6 9833.4 9940.0 38373.6 38380.8 38453.8 38714.8 38801.6 47940.0 52777.0 53564.5 54203.2 54554.2 12721.7 13080.7 13112.5 13227.7 13496.3 14171.8 14595.9 15198.5 15555.8 15576.8 13938.7 14005.3 14214.8 14333.6 15006.4 12800.5 12872.0 12893.9 13003.6 13174.8 13364.8 13399.4 13548.3 13627.2 14476.0 10217.4 10799.5 11086.8 11108.4 11282.8 10951.9 11940.0 11941.5 12078.2 12204.5 23:36:15 INFO - PROCESS | 9164 | -------- Summary: end -------- 23:36:15 INFO - PROCESS | 9164 | 23:36:16 INFO - TEST-INFO | 9164: exit 0 23:36:16 INFO - TEST-OK | dromaeo_css | took 1111233ms 23:36:16 INFO - TEST-START | kraken 23:36:16 INFO - operating with platform_type : linux_ 23:36:16 INFO - Initialising browser for kraken test... 23:36:16 INFO - TEST-INFO | started process 9393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQwQMyF/profile http://localhost:48056/getInfo.html) 23:36:20 INFO - PROCESS | 9393 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 23:36:20 INFO - PROCESS | 9393 | 23:36:20 INFO - PROCESS | 9393 | (process:9462): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:36:21 INFO - PROCESS | 9393 | __metrics Screen width/height:1600/1200 23:36:21 INFO - PROCESS | 9393 | colorDepth:24 23:36:21 INFO - PROCESS | 9393 | Browser inner width/height: 1024/697 23:36:21 INFO - PROCESS | 9393 | __metrics 23:36:22 ERROR - PROCESS | 9393 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:36:22 INFO - TEST-INFO | 9393: exit 0 23:36:22 INFO - Browser initialized. 23:36:22 INFO - Running cycle 1/1 for kraken test... 23:36:22 INFO - TEST-INFO | started process 9513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQwQMyF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:24 INFO - PROCESS | 9513 | 23:36:24 INFO - PROCESS | 9513 | (process:9575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:36:34 INFO - PROCESS | 9513 | RSS: Main: 163667968 23:36:34 INFO - PROCESS | 9513 | 23:36:37 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48056/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:38 INFO - PROCESS | 9513 | RSS: Main: 168685568 23:36:38 INFO - PROCESS | 9513 | 23:36:40 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48056/tests/kraken/driver.html?testName=audio-dft) 23:36:41 INFO - PROCESS | 9513 | RSS: Main: 168595456 23:36:41 INFO - PROCESS | 9513 | 23:36:44 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48056/tests/kraken/driver.html?testName=audio-fft) 23:36:45 INFO - PROCESS | 9513 | RSS: Main: 163422208 23:36:45 INFO - PROCESS | 9513 | 23:36:47 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48056/tests/kraken/driver.html?testName=audio-oscillator) 23:36:48 INFO - PROCESS | 9513 | RSS: Main: 163831808 23:36:48 INFO - PROCESS | 9513 | 23:36:50 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:50 INFO - PROCESS | 9513 | RSS: Main: 164184064 23:36:50 INFO - PROCESS | 9513 | 23:36:54 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48056/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:54 INFO - PROCESS | 9513 | RSS: Main: 164315136 23:36:54 INFO - PROCESS | 9513 | 23:36:58 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48056/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:58 INFO - PROCESS | 9513 | RSS: Main: 162955264 23:36:58 INFO - PROCESS | 9513 | 23:37:01 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48056/tests/kraken/driver.html?testName=json-parse-financial) 23:37:02 INFO - PROCESS | 9513 | RSS: Main: 163008512 23:37:02 INFO - PROCESS | 9513 | 23:37:04 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:37:04 INFO - PROCESS | 9513 | RSS: Main: 163233792 23:37:04 INFO - PROCESS | 9513 | 23:37:06 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:37:07 INFO - PROCESS | 9513 | RSS: Main: 163536896 23:37:07 INFO - PROCESS | 9513 | 23:37:09 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:37:10 INFO - PROCESS | 9513 | RSS: Main: 163758080 23:37:10 INFO - PROCESS | 9513 | 23:37:12 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:37:13 INFO - PROCESS | 9513 | RSS: Main: 163909632 23:37:13 INFO - PROCESS | 9513 | 23:37:15 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:37:16 INFO - PROCESS | 9513 | RSS: Main: 164159488 23:37:16 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | Cycle 1(1): loaded http://localhost:48056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48056/tests/kraken/driver.html?testName=ai-astar) 23:37:18 INFO - PROCESS | 9513 | RSS: Main: 165257216 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | __start_tp_report 23:37:18 INFO - PROCESS | 9513 | _x_x_mozilla_page_load 23:37:18 INFO - PROCESS | 9513 | _x_x_mozilla_page_load_details 23:37:18 INFO - PROCESS | 9513 | |i|pagename|runs| 23:37:18 INFO - PROCESS | 9513 | |0;ai-astar;107;111;103;111;111;112;105;110;110;110 23:37:18 INFO - PROCESS | 9513 | |1;audio-beat-detection;151;128;151;217;125;157;156;128;189;126 23:37:18 INFO - PROCESS | 9513 | |2;audio-dft;163;162;161;164;161;163;165;162;163;163 23:37:18 INFO - PROCESS | 9513 | |3;audio-fft;75;76;75;161;75;75;74;75;169;76 23:37:18 INFO - PROCESS | 9513 | |4;audio-oscillator;92;91;177;93;93;92;147;91;92;142 23:37:18 INFO - PROCESS | 9513 | |5;imaging-gaussian-blur;117;117;118;118;118;118;117;117;119;118 23:37:18 INFO - PROCESS | 9513 | |6;imaging-darkroom;147;146;147;147;148;146;147;146;147;147 23:37:18 INFO - PROCESS | 9513 | |7;imaging-desaturate;95;95;103;95;95;96;95;96;95;95 23:37:18 INFO - PROCESS | 9513 | |8;json-parse-financial;55;54;55;54;53;56;59;105;53;55 23:37:18 INFO - PROCESS | 9513 | |9;json-stringify-tinderbox;59;62;60;58;59;58;59;60;58;59 23:37:18 INFO - PROCESS | 9513 | |10;stanford-crypto-aes;78;79;78;82;81;78;85;81;83;78 23:37:18 INFO - PROCESS | 9513 | |11;stanford-crypto-ccm;129;118;119;117;122;120;126;118;203;126 23:37:18 INFO - PROCESS | 9513 | |12;stanford-crypto-pbkdf2;157;158;159;161;162;158;163;159;159;157 23:37:18 INFO - PROCESS | 9513 | |13;stanford-crypto-sha256-iterative;64;61;61;62;62;61;66;62;60;62 23:37:18 INFO - PROCESS | 9513 | __end_tp_report 23:37:18 INFO - PROCESS | 9513 | __start_cc_report 23:37:18 INFO - PROCESS | 9513 | _x_x_mozilla_cycle_collect,879 23:37:18 INFO - PROCESS | 9513 | __end_cc_report 23:37:18 INFO - PROCESS | 9513 | __startTimestamp1463380638568__endTimestamp 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | ------- Summary: start ------- 23:37:18 INFO - PROCESS | 9513 | Number of tests: 14 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:2.98 (2.7%) stddev-sans-first:3.07 23:37:18 INFO - PROCESS | 9513 | Values: 107.0 111.0 103.0 111.0 111.0 112.0 105.0 110.0 110.0 110.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:153.50 stddev:30.16 (19.6%) stddev-sans-first:31.98 23:37:18 INFO - PROCESS | 9513 | Values: 151.0 128.0 151.0 217.0 125.0 157.0 156.0 128.0 189.0 126.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 23:37:18 INFO - PROCESS | 9513 | Values: 163.0 162.0 161.0 164.0 161.0 163.0 165.0 162.0 163.0 163.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.95 (50.6%) stddev-sans-first:39.68 23:37:18 INFO - PROCESS | 9513 | Values: 75.0 76.0 75.0 161.0 75.0 75.0 74.0 75.0 169.0 76.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:31.87 (34.6%) stddev-sans-first:33.06 23:37:18 INFO - PROCESS | 9513 | Values: 92.0 91.0 177.0 93.0 93.0 92.0 147.0 91.0 92.0 142.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 23:37:18 INFO - PROCESS | 9513 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 119.0 118.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:37:18 INFO - PROCESS | 9513 | Values: 147.0 146.0 147.0 147.0 148.0 146.0 147.0 146.0 147.0 147.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.49 (2.6%) stddev-sans-first:2.62 23:37:18 INFO - PROCESS | 9513 | Values: 95.0 95.0 103.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:55.00 stddev:15.94 (29.0%) stddev-sans-first:16.81 23:37:18 INFO - PROCESS | 9513 | Values: 55.0 54.0 55.0 54.0 53.0 56.0 59.0 105.0 53.0 55.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.23 (2.1%) stddev-sans-first:1.30 23:37:18 INFO - PROCESS | 9513 | Values: 59.0 62.0 60.0 58.0 59.0 58.0 59.0 60.0 58.0 59.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:81.00 stddev:2.50 (3.1%) stddev-sans-first:2.51 23:37:18 INFO - PROCESS | 9513 | Values: 78.0 79.0 78.0 82.0 81.0 78.0 85.0 81.0 83.0 78.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:124.00 stddev:26.04 (21.0%) stddev-sans-first:27.62 23:37:18 INFO - PROCESS | 9513 | Values: 129.0 118.0 119.0 117.0 122.0 120.0 126.0 118.0 203.0 126.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.00 stddev:2.06 (1.3%) stddev-sans-first:2.01 23:37:18 INFO - PROCESS | 9513 | Values: 157.0 158.0 159.0 161.0 162.0 158.0 163.0 159.0 159.0 157.0 23:37:18 INFO - PROCESS | 9513 | 23:37:18 INFO - PROCESS | 9513 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.73 (2.8%) stddev-sans-first:1.69 23:37:18 INFO - PROCESS | 9513 | Values: 64.0 61.0 61.0 62.0 62.0 61.0 66.0 62.0 60.0 62.0 23:37:18 INFO - PROCESS | 9513 | -------- Summary: end -------- 23:37:18 INFO - PROCESS | 9513 | 23:37:19 INFO - TEST-INFO | 9513: exit 0 23:37:19 INFO - TEST-OK | kraken | took 63004ms 23:37:19 INFO - SUITE-END | took 1174s 23:37:19 INFO - Completed test suite (00:19:34) 23:37:19 INFO - javascript benchmark 23:37:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7110.324328756452, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.214446388403, 3150.810951342918, 3181.650018497965, 3193.2815116598767, 3203.2152122729935, 5259.500347466994, 5342.1452567589195, 5351.759170837312, 5353.652012619177, 5404.83785486436, 5296.232046353276, 5348.572114230862, 5352.705601191943, 5427.511523962842, 5428.185772134182, 4875.0, 4909.067277217335, 5029.497050294959, 5045.747712614373, 5093.752030752471, 744.3852277456339, 4930.28510865926, 4955.653104282702, 4958.752062396884, 5006.374203224597, 4938.629602779806, 4946.653734238605, 4968.726720030397, 4969.35398398206, 5026.29631851541, 4793.448753393334, 4997.800087996476, 5004.774785134678, 5024.949750502485, 5056.873578160538, 4773.546513081252, 4814.927776083362, 4819.855404337875, 4835.782389792468, 4859.805607775685, 5157.974210128963, 5283.498067683564, 5283.788648454057, 5288.68267903927, 5344.225087362311, 5669.348024977098, 5707.6290041147195, 5745.253117094751, 5746.683932383718, 5748.109043098327, 5760.9918264304, 5798.10129429939, 5830.446107619811, 5830.5044071254, 5873.735681894325, 5373.973130134364, 5409.0534156522845, 5421.891562168735, 5424.647397919122, 5429.918551221735, 5675.489205971482, 5826.621269617462, 5872.941270587325, 5890.293164820249, 5909.23179986599, 5726.79956201531, 5747.626404283708, 5749.252597162425, 5753.252077229933, 5756.42435756421, 5815.040518314515, 5818.650880947157, 5821.243238379068, 5828.766849326064, 5829.59192856496, 5579.246801681802, 5682.659040457585, 5722.113072473773, 5739.0, 5755.395683453261, 5567.415421380778, 5683.374828768832, 5757.712114394263, 5775.16260142277, 5833.38749431312, 4354.99835037943, 4368.737875727466, 4371.606555409965, 4387.4954380246045, 4409.11817636474, 3878.3600705883214, 3907.3748200288387, 3924.6664033557468, 3941.2511622792154, 3980.1840622672285, 5508.338999320107, 5594.1608758686525, 5607.327120745536, 5611.887762244733, 5615.410381909923, 5809.215755872903, 5880.470757631833, 5908.881822363529, 5911.024680927685, 5952.136940143655, 5422.945770542244, 5481.945180548143, 5487.259220005328, 5509.00837849183, 5531.668099914018, 4965.90068198634, 4967.0, 4997.325361076281, 5005.474425185376, 5028.899422011539, 5862.443067908627, 6023.036314189709, 6034.306054803666, 6043.939560604338, 6051.062085376773, 5752.884942301214, 5760.135979603093, 5776.220210271559, 5864.882702345843, 5875.236219291465, 6018.277806663228, 6027.035674292092, 6031.668258245839, 6053.697315134314, 6066.181065556093, 5586.301712285965, 5634.211210430461, 5679.630823996592, 5690.3456102548735, 5700.629459085146, 5784.2769653793275, 5796.42035796417, 5798.10129429939, 5806.82579522615, 5820.854478638068, 5693.345265294544, 5702.743376548148, 5704.714764261853, 5711.857203569944, 5726.341470730753, 5539.750711217925, 5628.774849006158, 5663.546916246608, 5669.744861481161, 5698.487136157766, 5431.429699881455, 5438.945610544002, 5446.591505637014, 5503.036968530411, 5670.631408958405, 5615.971920140373, 5655.943440565542, 5662.971685141548, 5676.914846277226, 5680.233168522197, 5405.864853378697, 5475.397706252229, 5499.725013749377, 5567.582431317748, 5569.248151499496], "value": 5300.124986755057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.5691630484203, 645.2225068792106, 646.5248042688626, 649.0945131541497, 664.8902931016381, 42309.78845105774, 43361.56638433615, 43617.0, 46343.841403964834, 47457.2034237261, 44583.0, 44739.328910066375, 45119.0, 45198.32202516965, 45247.77376113123, 8886.77783055424, 9040.321975851804, 9056.683016094437, 9093.40892841963, 9095.863562046574, 8888.333374996868, 8992.100789921022, 9000.324975626821, 9006.189442950134, 9009.099090091004, 8955.328350373715, 8981.416207946462, 8982.820343593125, 9004.954975225115, 9025.59384827681, 8948.463092214455, 8979.820403591892, 8981.910180898205, 8985.0, 8990.910090899073, 8861.113888611088, 8946.060663630291, 8966.730998070068, 8974.461532308082, 8987.281017518582, 42415.57584424147, 42851.785741071406, 43050.35424468636, 43151.0, 43311.783441082596, 3251.7723759336855, 3460.1349662584353, 3486.3682999471944, 3511.5434993450945, 3517.278957813642, 33133.502997455056, 33201.833990830135, 33467.832660836786, 34818.47772283418, 34864.82567587171, 4273.893152671208, 4295.763732994684, 4348.608625223745, 4380.956190438087, 4417.337399390085, 370948.0, 372057.0, 372068.0, 373014.1349293263, 374021.0, 34883.0, 59242.70378648079, 59618.317175726326, 59757.0, 59772.10341844876, 35716.0, 37774.62225377766, 37786.43320350197, 37918.0, 38122.809385952896, 13962.301884905713, 14131.081479703786, 14171.370292416297, 14225.07537010091, 14265.64335891611, 11721.4139293035, 11732.648020559396, 11733.237339573072, 11765.941170294265, 11833.053355731521, 8559.315254779603, 8631.611577479029, 8633.395662303705, 8665.740027799176, 8738.86891696625, 3300.818454984999, 3341.365140623274, 3345.6654334566347, 3353.9329213415594, 3384.356972175328, 978.6868202175235, 1033.4449493741654, 1043.9164866810636, 1043.95824167034, 1176.4823477669797, 31386.843065784982, 32410.027699169063, 32424.83787581047, 32608.347833043208, 32792.34415311681, 1145.169751929861, 1206.3546002888588, 1217.4278089298016, 1241.74043136766, 1296.941637626309, 17179.141042947802, 17255.22351494186, 17323.82676173222, 17351.219195136247, 17557.736633950502, 570466.0, 572253.0, 574414.0, 574527.0, 576870.0, 59774.0, 60624.69687651622, 60814.74296799181, 60887.0, 61049.69475152596, 1381.8203633527578, 1406.6202125426078, 1415.7380884536394, 1416.5750274917484, 1439.1509009684337, 32335.0, 32593.34813303768, 32682.50976235406, 32864.342713145124, 33244.667553325125, 51391.48608513867, 51827.481725183774, 51846.48153518417, 52017.0, 52311.0, 499971.0, 500346.0, 503838.0, 504104.0, 504202.0, 27924.0, 28259.293517662223, 28514.287142821595, 28621.427571448872, 28795.424091517634, 48691.0, 48846.0, 49053.509464906325, 49444.0, 49590.25614615712, 41629.79185104055, 41649.0, 42145.578544214164, 42813.57186428096, 43187.0, 40990.0, 41632.583674162874, 41998.79000604978, 42490.57509424866, 42626.57373426226, 36094.8195259022, 41765.37351939663, 43686.344704828814, 43947.34078988754, 44889.0, 35664.465033024004, 37015.25969480649, 37561.4365784508, 38993.220135597694, 39562.0, 29234.7076529232, 29270.26824329409, 29773.702262977095, 29883.55174672338, 30174.0], "value": 19362.51157095086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.6073587148722, 399.82207917476734, 401.3417994489038, 402.42051445917883, 420.0779289459637, 15276.465323713672, 18422.078896055194, 19842.206311747548, 19882.20471181153, 19925.402237932885, 18511.16699748511, 18739.0, 19300.324488642902, 19428.708569371473, 19492.902535487337, 5481.972590137054, 5591.916121258185, 5659.575531835108, 5667.801626943058, 5678.034734095214, 5476.58925580581, 5623.0, 5624.465675760816, 5628.268325117729, 5632.859178520549, 5391.81128660497, 5601.439856014386, 5609.102543593026, 5643.887122257553, 5663.603547751659, 5539.41836107209, 5585.720713964326, 5623.437656234385, 5629.380768115504, 5640.464155905223, 4859.708417494961, 4943.579795717368, 4946.950530494685, 4986.202207646796, 4994.625403094782, 22325.43257525389, 22337.218197363014, 22984.195553155725, 23307.3007809766, 23467.647985280233, 2186.9562608747897, 2303.896324665394, 2367.5501654685554, 2369.609014512603, 2429.817763667714, 9422.104900034554, 9428.198603118743, 9594.992525784763, 9640.373375730625, 9933.453660048694, 1915.7413749143966, 1940.6596457825146, 1941.7864034956144, 1988.4929343017438, 2053.8254248388903, 80165.19834801636, 80910.59544702298, 82468.58765706193, 82923.5853820727, 83192.16807831965, 9477.857832132524, 9978.600855965826, 10729.78540429187, 10990.560377584807, 11039.72400689973, 11247.0, 11878.762424751629, 12049.638510844688, 14959.0, 15046.849531504764, 7320.048393708784, 7433.331000209899, 7435.1449583297535, 7505.4746167767735, 7628.580428076509, 7450.180480147288, 7746.341560967381, 7759.185285544936, 7843.294103530709, 7900.130985591581, 3773.3019391412126, 3807.58116607173, 3815.3323168445413, 3826.445165450994, 3843.2121415109837, 1812.918418671163, 1828.652556014353, 1829.8719089663596, 1834.055461437361, 1856.4059500959834, 409.9877003689894, 424.6602717825727, 1021.1932573267185, 1036.445332001997, 1061.1722856172198, 10885.782284354269, 11428.0, 11461.885381146249, 11509.424528773528, 11594.420278986017, 427.54466493184657, 441.942547468827, 442.4469413233458, 463.0992719161199, 960.4237457525429, 10154.898451015542, 10813.62152324665, 10857.51141198648, 10889.509972051277, 10935.83596246057, 449916.0, 453496.0, 454696.0, 468087.0, 483762.0, 93608.0, 93948.0, 94503.0, 95059.0, 96538.51730741301, 910.854263317866, 917.7063339731222, 925.0333401595349, 927.730958022166, 928.5032507608532, 16992.150392480573, 17045.0, 17059.317627294768, 17338.826611733723, 17354.652906941537, 37960.0, 38288.80855595704, 39133.60866391299, 39169.804150979064, 39350.0, 56892.71553642205, 57036.0, 57646.0, 57701.13448298195, 58190.709046454496, 7747.535147891144, 7754.651040703069, 8387.874181887399, 8519.361047921308, 8536.871946920677, 12831.0, 12998.220106793622, 13150.27673477968, 13345.332733363099, 13358.866411335763, 11622.593209237637, 11791.823122652995, 11869.287842729464, 12161.574344897886, 12196.81704774447, 11627.0, 11774.411279436164, 11781.057515398576, 11815.232009919328, 11945.581904633296, 12128.514859405524, 12244.265344079384, 12277.20198187115, 12363.0, 12480.75038499243, 7632.885506717293, 7724.304812566896, 7733.0, 7777.805554860947, 8207.466514676527, 11939.223950443193, 11952.76094478088, 12059.457324420599, 12078.21491603043, 12080.697982550506], "value": 8609.524569406554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.3173556032007, 1522.7182971150337, 1709.4187976088128, 1822.690142675745, 1840.411068458094, 8046.235607617282, 8621.224089831914, 8711.0, 9070.002299747031, 9163.816723665523, 8759.343049271314, 9031.54842257886, 9038.322125840572, 9067.0, 9083.046280140588, 2080.5838832233576, 2097.674860396641, 2105.7788932162134, 2108.1356643776053, 2109.198504568262, 2079.6984437256588, 2100.12844669462, 2118.608057509358, 2124.076026928291, 2126.5215326551556, 2076.7923207679187, 2080.0327847550884, 2087.6764101564204, 2090.4982804127053, 2135.9145634174615, 2059.320424259998, 2077.9168833246654, 2079.189116244666, 2081.687746837971, 2081.7918208179212, 2059.5983783162287, 2066.1941842681367, 2074.4295318787304, 2084.593504266669, 2085.6141613801497, 8927.910720892838, 9120.680776172801, 9123.908760912373, 9131.726048218565, 9142.085791420872, 5062.0, 5128.307678463397, 5153.2785410042625, 5168.483151684802, 5191.221316802472, 3285.342931413703, 3291.0949488890506, 3346.7991920484606, 3371.8819841305435, 3399.5240666306736, 1101.4878081691973, 1141.2809929744292, 1141.4349896801054, 1152.8962393384636, 1186.9643910682694, 12608.936955315348, 12720.87279127206, 12733.236005839679, 12749.17130386522, 12774.233545987177, 4387.341898715218, 4437.644988400984, 4516.299973504112, 4544.295634176708, 4575.611073058827, 10679.19906007037, 10682.679519614425, 10699.518521666543, 10705.411202383788, 10706.25056246071, 5261.421243663194, 5286.7356632169, 5292.92060619091, 5295.443978382292, 5304.734763261821, 4324.675649326313, 4555.2711566149255, 4666.883327916829, 4721.551452611996, 4838.758062096881, 3940.2119576084897, 3940.2513522430645, 4015.1166743316426, 4045.8179381927885, 4101.692373072032, 1179.929204247748, 1220.4934951995, 1227.4353797253184, 1236.4312416288608, 1240.3116270469795, 941.3692825806726, 1011.549860312154, 1030.567161792049, 1039.26212389203, 1050.207093644309, 6278.717457714414, 6290.55966082379, 6337.96831015842, 6395.0, 6403.935960640427, 408.45675251914884, 408.9386592011222, 410.12643070260157, 411.8929078439567, 1059.210887888528, 4290.978545107255, 4425.0, 4463.486699029653, 4487.41663583732, 4498.797554110008, 11122.721931951604, 11384.772304553862, 11403.486843092081, 11416.885831141748, 11429.257098288585, 10635.042846143884, 11218.326900386002, 11295.887041129483, 11308.717282068013, 11376.260543064674, 8171.7548473545885, 8443.57782110892, 8482.957585212034, 8542.10307917672, 8557.10150434208, 6276.968615157078, 6383.0, 6509.73961041572, 6529.836754081186, 6587.242467116343, 10447.373157610567, 10531.05220530156, 10533.0, 10578.947105264424, 10638.73403164927, 10068.144207742424, 10324.22568307395, 10381.117605003357, 10431.843522347019, 10638.73403164927, 7875.369970402468, 8315.584220788814, 8336.708215212439, 8611.95694021526, 8666.956665216634, 8222.753317400488, 8250.133735957877, 8271.62777674994, 8338.332933365195, 8339.20777526134, 7408.814779630552, 7592.164861865301, 7715.267049630276, 7723.189065148079, 7820.882686759817, 7617.200193979553, 7698.692052317844, 7746.380289576933, 7765.72819951299, 7870.881936770838, 7129.679164437716, 7187.820304492429, 7192.244814294633, 7198.316159964795, 7220.855582888208, 5302.787888484418, 5595.916061259003, 5660.915086273627, 5663.405342438985, 5751.48236658686, 5554.722263886871, 5598.776048957996, 5655.547556195412, 5674.148877668383, 5741.712914354349], "value": 4604.05854998138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9955300670489, 309.5372418234739, 312.67950350890334, 316.2157848535633, 317.68549136355, 5502.9174562381595, 5538.972305138469, 5647.717614119293, 5737.598368114233, 5787.623804452713, 5596.2165296858475, 5598.86002849929, 5601.327840659126, 5621.409751976034, 5628.549716022719, 4214.702986872155, 4278.358246263055, 4290.6138447539715, 4302.935455968147, 4334.436523251973, 4065.6544193743566, 4199.706020578561, 4219.303814870543, 4352.52122266552, 4362.781860906958, 4164.0, 4170.039272116801, 4209.800206941022, 4237.364395340693, 4272.444582204324, 4264.677949835545, 4271.530131685512, 4299.613034826849, 4309.396684464177, 4319.460067491564, 3544.680978711928, 3710.0, 3711.981440092782, 3722.497462842509, 3733.7199710021855, 5432.75552600134, 5435.673859568399, 5452.2094296327205, 5452.491853747281, 5469.671819690831, 4847.673116903906, 4910.803567857281, 4925.532074452921, 4929.285253638202, 4931.950680493221, 5606.6636001840025, 5841.824745257649, 5847.0, 5875.38308477608, 5875.882482350372, 4069.104796944667, 4085.5301640311445, 4099.1596722672075, 4109.815058322382, 4121.9381709274385, 6125.448709616111, 6195.933013158516, 6215.254169499689, 6222.439980401786, 6241.28225254097, 4024.8993775155855, 4164.12553363797, 4169.353750168729, 4169.874903752892, 4183.790810459464, 4190.832366705358, 4197.160567886435, 4198.748075115503, 4210.957890421118, 4225.176090662291, 4881.219004959261, 4904.950950490521, 4921.704697718148, 4948.084604348207, 4955.256711493233, 5851.678157701367, 5906.675132867734, 5918.674472903946, 5953.732082056231, 5980.820575382745, 1435.727211829749, 1457.227669335254, 1462.5319897632655, 1469.8015767871414, 1479.5413421839048, 870.5299138465284, 906.3610154840821, 912.7449756584696, 923.2936803345447, 931.2410385535767, 5048.217526283432, 5093.516115968977, 5129.410117836496, 5153.381594208644, 5176.06830770465, 5367.731613419313, 5410.08028635133, 5423.755930983115, 5452.49185374732, 5455.754491047913, 4897.4817806480105, 4991.831820429909, 5113.360829896263, 5193.714345710947, 5197.908439227729, 2912.3592809582283, 2919.3431477917297, 2929.9745089219027, 2938.882444702188, 2941.426421847719, 5528.889422211533, 5562.666240025531, 5579.553635709133, 5585.860353491195, 5613.803516876971, 5461.5357694596405, 5732.828015159552, 6187.597806142587, 6212.47193988516, 6288.8427789304715, 6286.717097730613, 6372.36276372359, 6406.391392817675, 6431.260405053479, 6455.225372955181, 5953.851153721192, 6115.541334400027, 6134.938650613437, 6136.417040381157, 6138.416850399205, 6026.323942395048, 6041.214642096499, 6059.3334733178435, 6069.514438844793, 6073.5748497604745, 5763.5965482417505, 6332.715027823667, 6359.96820015897, 6392.9360706392345, 6406.295307516077, 4106.917861642691, 4174.624283814472, 4193.840172311201, 4197.433346498184, 4225.57744225575, 6033.5173186145885, 6081.996470582304, 6119.510439164945, 6134.539909506894, 6183.783567575113, 5701.201268032706, 5895.616784908967, 5915.467607915309, 5934.6350339421315, 5937.643741375531, 5850.1626711044255, 5878.529717622666, 5899.348182508905, 5900.616459930091, 5902.085176797603, 5798.652080875161, 5805.767769289181, 5833.141760537391, 5848.444397782204, 5863.677497737665, 5686.2323586315315, 6004.519638429003, 6069.241344831896, 6080.7567697291615, 6089.177960975212, 5830.737616807169, 5832.104566015977, 5883.999440190356, 5892.558058145742, 5909.202257695156], "value": 4372.645056771061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.6702118620773, 804.3002587748656, 843.7257891185365, 881.8544940084886, 898.460923445933, 14401.927990360047, 14545.709085818304, 14649.04781189222, 14668.853311466883, 14685.265736713174, 12119.333436661002, 13661.316934153278, 13705.314734263296, 13707.109037912554, 13708.314584270796, 810.8783682447621, 839.0183485322157, 839.1147339556795, 839.8992120945464, 841.4194205997842, 840.8822764812932, 841.146236569882, 841.8905542279496, 848.3510114762212, 849.9405041647087, 890.6838072484272, 890.812929284851, 891.7636826241052, 893.9016708162129, 894.3292530602048, 877.3814460805118, 882.4925667741043, 883.9823203535925, 885.2298500304776, 888.7333799860016, 632.9398707122816, 637.8022812928007, 638.2181827261613, 638.9520785941027, 640.4812102197235, 14162.433502659882, 14189.290535473288, 14214.147151170859, 14241.145531268054, 14254.92872535641, 13917.443302267999, 13961.930190349085, 14161.29193540319, 14243.928780356031, 14251.287435628281, 12739.299338536377, 12859.0, 13003.349832508336, 13006.609801705965, 13066.934665326613, 4622.745748983804, 4651.209294419957, 4660.231061874787, 4675.111728771557, 4731.124741922721, 60755.39244607541, 60771.39228607702, 61246.69376653133, 61424.07863882045, 61579.0, 11340.432978351215, 11351.0, 11510.654680359603, 11536.25014374063, 11914.761704765857, 20615.38153855387, 20916.267930622354, 20935.476613084797, 20980.0, 20988.790112098683, 8685.869711954325, 8760.693375731818, 8942.821143577223, 9062.592183351764, 9097.954510227406, 4713.552212539872, 4797.280407938767, 4807.831725889577, 4864.051509955595, 4935.851924442272, 3508.386032444312, 3580.0870777951454, 3589.533360663097, 3598.9280214395567, 3613.602503724588, 671.332024635481, 684.9794506164823, 695.6938946863465, 702.3503259484957, 707.2255879811598, 762.1768490030864, 762.4091329219899, 772.8956590860274, 783.8314762326128, 786.7679034684782, 9253.259739220981, 9727.9027209727, 10019.098281154731, 10038.799224015625, 10071.24465665078, 758.0940775772898, 773.5474747272908, 775.5308038636656, 777.5179388778993, 790.9011373578303, 4596.4024676791805, 4613.2388155953895, 4755.096531658974, 4759.286107083965, 4768.523147685204, 63972.562332201356, 65478.0, 71021.0, 71699.28300716926, 71782.28217717861, 56053.43946560564, 58527.12209316863, 61809.69095154495, 62297.0, 70622.0, 57283.713581431824, 59552.404475955555, 60352.698236508535, 60799.69600151971, 60973.39026609677, 9514.762130946781, 9818.558164882455, 9828.606855725691, 9833.360831545926, 9940.0, 38373.61626383701, 38380.80809595934, 38453.80773096117, 38714.80642596769, 38801.6119838798, 47940.0, 52777.0, 53564.46435535595, 54203.18695219496, 54554.181687275515, 12721.745565088831, 13080.672983175116, 13112.475500979854, 13227.735445291233, 13496.32518374097, 14171.787423188867, 14595.92702036483, 15198.46805361807, 15555.76666349983, 15576.766348505009, 13938.651533711738, 14005.299735013004, 14214.786778198542, 14333.64165895861, 15006.399744010554, 12800.487980480677, 12872.0, 12893.93553032229, 13003.609891703263, 13174.802377964146, 13364.799528007283, 13399.397027133997, 13548.254845983565, 13627.182369057888, 14476.0, 10217.438040907822, 10799.460026998462, 11086.778264434504, 11108.390262917499, 11282.830757538808, 10951.890481095086, 11940.0, 11941.46263418131, 12078.21491603043, 12204.511819527119], "value": 7264.114309483145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 103.0, 111.0, 111.0, 112.0, 105.0, 110.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 151.0, 217.0, 125.0, 157.0, 156.0, 128.0, 189.0, 126.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 164.0, 161.0, 163.0, 165.0, 162.0, 163.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 161.0, 75.0, 75.0, 74.0, 75.0, 169.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 177.0, 93.0, 93.0, 92.0, 147.0, 91.0, 92.0, 142.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 103.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 53.0, 56.0, 59.0, 105.0, 53.0, 55.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 60.0, 58.0, 59.0, 58.0, 59.0, 60.0, 58.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 82.0, 81.0, 78.0, 85.0, 81.0, 83.0, 78.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 118.0, 119.0, 117.0, 122.0, 120.0, 126.0, 118.0, 203.0, 126.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 159.0, 161.0, 162.0, 158.0, 163.0, 159.0, 159.0, 157.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 62.0, 62.0, 61.0, 66.0, 62.0, 60.0, 62.0], "value": 62.1, "unit": "score"}]}]} 23:37:19 INFO - Return code: 0 23:37:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:37:19 ERROR - # TBPL SUCCESS # 23:37:19 INFO - Running post-action listener: _resource_record_post_action 23:37:19 INFO - ##### 23:37:19 INFO - ##### Finished run-tests step (success) 23:37:19 INFO - ##### 23:37:19 INFO - Running post-run listener: _resource_record_post_run 23:37:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 3317760; Write bytes: 361635840; Read time: 328; Write time: 405952 23:37:19 INFO - TinderboxPrint: CPU usage
13.4% 23:37:19 INFO - TinderboxPrint: I/O read bytes / time
3,317,760 / 328 23:37:19 INFO - TinderboxPrint: I/O write bytes / time
361,635,840 / 405,952 23:37:19 INFO - TinderboxPrint: CPU idle
8,235.5 (86.6%) 23:37:19 INFO - TinderboxPrint: CPU user
1,217.9 (12.8%) 23:37:19 INFO - TinderboxPrint: Swap in / out
0 / 0 23:37:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 75960320; Read time: 0; Write time: 68972 23:37:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 3317760; Write bytes: 285675520; Read time: 328; Write time: 336980 23:37:20 INFO - Running post-run listener: _upload_blobber_files 23:37:20 INFO - Blob upload gear active. 23:37:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:37:20 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 23:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:37:20 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:24 INFO - (blobuploader) - INFO - Done attempting. 23:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:25 INFO - (blobuploader) - INFO - Done attempting. 23:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:25 INFO - (blobuploader) - INFO - Done attempting. 23:37:25 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:25 INFO - Return code: 0 23:37:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b81270f9a7cac39a15e77d02e67c4366d310b4bc02a6a242269ae18e647cfaec09f94f6de62f9fca502de4422cd789a38602fcef9654fd69e327f338dbaaf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97edc48b8705702f452b9dc19ab0b31226aaf555a8a93d15c64757b6787594b89b42ff0fbaa9d782535f20e72cd9e87de01258d6da1439ea4e1ef80530b1ce5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bb07aab040f5b25a382245ad5d2b426687814599337517a23bb7924a385c6969f2f965ad57746b95365ef145a335563aadfa0713c866cd4d3490d7d728d209c"} 23:37:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:25 INFO - Contents: 23:37:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b81270f9a7cac39a15e77d02e67c4366d310b4bc02a6a242269ae18e647cfaec09f94f6de62f9fca502de4422cd789a38602fcef9654fd69e327f338dbaaf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97edc48b8705702f452b9dc19ab0b31226aaf555a8a93d15c64757b6787594b89b42ff0fbaa9d782535f20e72cd9e87de01258d6da1439ea4e1ef80530b1ce5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bb07aab040f5b25a382245ad5d2b426687814599337517a23bb7924a385c6969f2f965ad57746b95365ef145a335563aadfa0713c866cd4d3490d7d728d209c"} 23:37:25 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:25 INFO - Copying logs to upload dir... 23:37:25 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.896211 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-15 23:37:25.588644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 23:37:25.592272) ========= 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=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b81270f9a7cac39a15e77d02e67c4366d310b4bc02a6a242269ae18e647cfaec09f94f6de62f9fca502de4422cd789a38602fcef9654fd69e327f338dbaaf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97edc48b8705702f452b9dc19ab0b31226aaf555a8a93d15c64757b6787594b89b42ff0fbaa9d782535f20e72cd9e87de01258d6da1439ea4e1ef80530b1ce5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bb07aab040f5b25a382245ad5d2b426687814599337517a23bb7924a385c6969f2f965ad57746b95365ef145a335563aadfa0713c866cd4d3490d7d728d209c"} build_url:https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/E1C1mMrcTU2u2af2NuPgHQ/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/sha512/48b81270f9a7cac39a15e77d02e67c4366d310b4bc02a6a242269ae18e647cfaec09f94f6de62f9fca502de4422cd789a38602fcef9654fd69e327f338dbaaf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97edc48b8705702f452b9dc19ab0b31226aaf555a8a93d15c64757b6787594b89b42ff0fbaa9d782535f20e72cd9e87de01258d6da1439ea4e1ef80530b1ce5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bb07aab040f5b25a382245ad5d2b426687814599337517a23bb7924a385c6969f2f965ad57746b95365ef145a335563aadfa0713c866cd4d3490d7d728d209c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-15 23:37:25.617146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:37:25.617501) ========= 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=af724c981e2a0f424dbabf99000001e7-1463375825.382325-495466915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-15 23:37:25.702784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 23:37:25.703111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-15 23:37:25.703397) ========= ========= Total master_lag: 0.16 =========