builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1464109617.39 results: success (0) buildid: 20160524073032 builduid: 1ea91d40768944f3a4026f4ad51eb420 revision: 829d3be6ba648b838ee1953fdfa1a477dace752f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.393904) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.394352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.394635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.406318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.406588) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 10:06:57-- 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% 50.9M=0s 2016-05-24 10:06:57 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.523212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.523525) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:57.572805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 10:06:57.573155) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 829d3be6ba648b838ee1953fdfa1a477dace752f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 829d3be6ba648b838ee1953fdfa1a477dace752f --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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 10:06:57,662 truncating revision to first 12 chars 2016-05-24 10:06:57,662 Setting DEBUG logging. 2016-05-24 10:06:57,662 attempt 1/10 2016-05-24 10:06:57,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/829d3be6ba64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 10:06:59,045 unpacking tar archive at: mozilla-central-829d3be6ba64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.679956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 10:06:59.266087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:59.266415) ========= script_repo_revision: 829d3be6ba648b838ee1953fdfa1a477dace752f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:59.266840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:59.267127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:06:59.275532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-24 10:06:59.275932) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:59 INFO - MultiFileLogger online at 20160524 10:06:59 in /builds/slave/test 10:06:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:59 INFO - {'append_to_log': False, 10:06:59 INFO - 'base_work_dir': '/builds/slave/test', 10:06:59 INFO - 'blob_upload_branch': 'Firefox', 10:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:59 INFO - 'branch': 'Firefox', 10:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:59 INFO - 'config_files': ('talos/linux_config.py',), 10:06:59 INFO - 'default_actions': ('clobber', 10:06:59 INFO - 'read-buildbot-config', 10:06:59 INFO - 'download-and-extract', 10:06:59 INFO - 'populate-webroot', 10:06:59 INFO - 'create-virtualenv', 10:06:59 INFO - 'install', 10:06:59 INFO - 'run-tests'), 10:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:59 INFO - 'download_minidump_stackwalk': True, 10:06:59 INFO - 'download_symbols': 'ondemand', 10:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:59 INFO - 'installer_path': 'installer.exe', 10:06:59 INFO - 'log_level': 'info', 10:06:59 INFO - 'log_name': 'talos', 10:06:59 INFO - 'log_to_console': True, 10:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:59 INFO - 'opt_config_files': (), 10:06:59 INFO - 'pip_index': False, 10:06:59 INFO - 'sps_profile': False, 10:06:59 INFO - 'sps_profile_interval': 0, 10:06:59 INFO - 'suite': 'dromaeojs-e10s', 10:06:59 INFO - 'system_bits': '32', 10:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:59 INFO - 'title': 'talos-linux64-ix-040', 10:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:59 INFO - 'use_talos_json': True, 10:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:59 INFO - 'work_dir': 'build'} 10:06:59 INFO - ##### 10:06:59 INFO - ##### Running clobber step. 10:06:59 INFO - ##### 10:06:59 INFO - Running pre-action listener: _resource_record_pre_action 10:06:59 INFO - Running main action method: clobber 10:06:59 INFO - rmtree: /builds/slave/test/build 10:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:59 INFO - Running post-action listener: _resource_record_post_action 10:06:59 INFO - ##### 10:06:59 INFO - ##### Finished clobber step (success) 10:06:59 INFO - ##### 10:06:59 INFO - ##### 10:06:59 INFO - ##### Running read-buildbot-config step. 10:06:59 INFO - ##### 10:06:59 INFO - Running pre-action listener: _resource_record_pre_action 10:06:59 INFO - Running main action method: read_buildbot_config 10:06:59 INFO - Using buildbot properties: 10:06:59 INFO - { 10:06:59 INFO - "project": "", 10:06:59 INFO - "product": "firefox", 10:06:59 INFO - "script_repo_revision": "production", 10:06:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:06:59 INFO - "repository": "", 10:06:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:06:59 INFO - "buildid": "20160524073032", 10:06:59 INFO - "pgo_build": "True", 10:06:59 INFO - "basedir": "/builds/slave/test", 10:06:59 INFO - "buildnumber": 736, 10:06:59 INFO - "slavename": "talos-linux64-ix-040", 10:06:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:06:59 INFO - "platform": "ubuntu64_hw", 10:06:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:06:59 INFO - "branch": "mozilla-central", 10:06:59 INFO - "repo_path": "mozilla-central", 10:06:59 INFO - "revision": "829d3be6ba648b838ee1953fdfa1a477dace752f", 10:06:59 INFO - "stage_platform": "linux64-pgo", 10:06:59 INFO - "builduid": "1ea91d40768944f3a4026f4ad51eb420", 10:06:59 INFO - "slavebuilddir": "test" 10:06:59 INFO - } 10:06:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:06:59 INFO - Running post-action listener: _resource_record_post_action 10:06:59 INFO - ##### 10:06:59 INFO - ##### Finished read-buildbot-config step (success) 10:06:59 INFO - ##### 10:06:59 INFO - ##### 10:06:59 INFO - ##### Running download-and-extract step. 10:06:59 INFO - ##### 10:06:59 INFO - Running pre-action listener: _resource_record_pre_action 10:06:59 INFO - Running main action method: download_and_extract 10:06:59 INFO - mkdir: /builds/slave/test/build/tests 10:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:59 INFO - https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:00 INFO - Downloaded 1361 bytes. 10:07:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:07:00 INFO - Using the following test package requirements: 10:07:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'jsshell-linux-x86_64.zip'], 10:07:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:00 INFO - https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:01 INFO - Downloaded 24417068 bytes. 10:07:01 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'] 10:07:01 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 10:07:02 INFO - Return code: 0 10:07:02 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 10:07:02 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')]} 10:07:02 INFO - https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:03 INFO - Downloaded 24417068 bytes. 10:07:03 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'] 10:07:03 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 10:07:05 INFO - Return code: 0 10:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:05 INFO - https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:06 INFO - Downloaded 10840359 bytes. 10:07:06 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'] 10:07:06 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 10:07:06 INFO - Return code: 0 10:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:06 INFO - https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DoNns8flQRSK0zqagCScPg/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 10:07:08 INFO - Downloaded 58637104 bytes. 10:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:08 INFO - mkdir: /builds/slave/test/properties 10:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:08 INFO - Contents: 10:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:08 INFO - Running post-action listener: _resource_record_post_action 10:07:08 INFO - Running post-action listener: set_extra_try_arguments 10:07:08 INFO - ##### 10:07:08 INFO - ##### Finished download-and-extract step (success) 10:07:08 INFO - ##### 10:07:08 INFO - ##### 10:07:08 INFO - ##### Running populate-webroot step. 10:07:08 INFO - ##### 10:07:08 INFO - Running pre-action listener: _resource_record_pre_action 10:07:08 INFO - Running main action method: populate_webroot 10:07:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:08 INFO - '--tppagecycles', 10:07:08 INFO - '7'], 10:07:08 INFO - 'tests': ['tsvgm']}}, 10:07:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['damp', 'tps']}, 10:07:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'tests': ['damp', 'tps']}, 10:07:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['dromaeo_dom']}, 10:07:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['a11yr', 10:07:08 INFO - 'ts_paint', 10:07:08 INFO - 'tpaint', 10:07:08 INFO - 'sessionrestore', 10:07:08 INFO - 'sessionrestore_no_auto_restore', 10:07:08 INFO - 'tabpaint']}, 10:07:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['tsvgx', 10:07:08 INFO - 'tsvgr_opacity', 10:07:08 INFO - 'tart', 10:07:08 INFO - 'tscrollx', 10:07:08 INFO - 'cart']}, 10:07:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:08 INFO - 'tsvgr_opacity', 10:07:08 INFO - 'tart', 10:07:08 INFO - 'tscrollx', 10:07:08 INFO - 'cart']}, 10:07:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'talos_options': ['--disable-e10s'], 10:07:08 INFO - 'tests': ['tp5o']}, 10:07:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'tests': ['tp5o']}, 10:07:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'talos_options': ['--disable-e10s', 10:07:08 INFO - '--xperf_path', 10:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:08 INFO - 'tests': ['tp5n']}, 10:07:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:08 INFO - 'talos_options': ['--xperf_path', 10:07:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:08 INFO - 'tests': ['tp5n']}}, 10:07:08 INFO - 'talos.zip': {'path': '', 10:07:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:08 INFO - Running post-action listener: _resource_record_post_action 10:07:08 INFO - ##### 10:07:08 INFO - ##### Finished populate-webroot step (success) 10:07:08 INFO - ##### 10:07:08 INFO - ##### 10:07:08 INFO - ##### Running create-virtualenv step. 10:07:08 INFO - ##### 10:07:08 INFO - Running pre-action listener: _resource_record_pre_action 10:07:08 INFO - Running main action method: create_virtualenv 10:07:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:08 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 10:07:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:08 INFO - Using real prefix '/usr' 10:07:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:11 INFO - Installing pip.................done. 10:07:11 INFO - Return code: 0 10:07:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:11 INFO - Using env: {'DISPLAY': ':0', 10:07:11 INFO - 'HOME': '/home/cltbld', 10:07:11 INFO - 'LANG': 'en_US.UTF-8', 10:07:11 INFO - 'LANGUAGE': 'en_US:en', 10:07:11 INFO - 'LOGNAME': 'cltbld', 10:07:11 INFO - 'MAIL': '/var/mail/cltbld', 10:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:11 INFO - 'MOZ_NO_REMOTE': '1', 10:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:11 INFO - 'NO_EM_RESTART': '1', 10:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:11 INFO - 'PWD': '/builds/slave/test', 10:07:11 INFO - 'SHELL': '/bin/bash', 10:07:11 INFO - 'SHLVL': '1', 10:07:11 INFO - 'TERM': 'linux', 10:07:11 INFO - 'TMOUT': '86400', 10:07:11 INFO - 'USER': 'cltbld', 10:07:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:11 INFO - '_': '/tools/buildbot/bin/python'} 10:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:11 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 10:07:11 INFO - Cleaning up... 10:07:11 INFO - Return code: 0 10:07:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:11 INFO - Using env: {'DISPLAY': ':0', 10:07:11 INFO - 'HOME': '/home/cltbld', 10:07:11 INFO - 'LANG': 'en_US.UTF-8', 10:07:11 INFO - 'LANGUAGE': 'en_US:en', 10:07:11 INFO - 'LOGNAME': 'cltbld', 10:07:11 INFO - 'MAIL': '/var/mail/cltbld', 10:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:11 INFO - 'MOZ_NO_REMOTE': '1', 10:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:11 INFO - 'NO_EM_RESTART': '1', 10:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:11 INFO - 'PWD': '/builds/slave/test', 10:07:11 INFO - 'SHELL': '/bin/bash', 10:07:11 INFO - 'SHLVL': '1', 10:07:11 INFO - 'TERM': 'linux', 10:07:11 INFO - 'TMOUT': '86400', 10:07:11 INFO - 'USER': 'cltbld', 10:07:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:11 INFO - '_': '/tools/buildbot/bin/python'} 10:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:12 INFO - Downloading/unpacking psutil>=3.1.1 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:14 INFO - Installing collected packages: psutil 10:07:14 INFO - Running setup.py install for psutil 10:07:14 INFO - building 'psutil._psutil_linux' extension 10:07:14 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 10:07:14 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 10:07:14 INFO - building 'psutil._psutil_posix' extension 10:07:14 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 10:07:14 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 10:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:14 INFO - Successfully installed psutil 10:07:14 INFO - Cleaning up... 10:07:14 INFO - Return code: 0 10:07:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:14 INFO - Using env: {'DISPLAY': ':0', 10:07:14 INFO - 'HOME': '/home/cltbld', 10:07:14 INFO - 'LANG': 'en_US.UTF-8', 10:07:14 INFO - 'LANGUAGE': 'en_US:en', 10:07:14 INFO - 'LOGNAME': 'cltbld', 10:07:14 INFO - 'MAIL': '/var/mail/cltbld', 10:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:14 INFO - 'MOZ_NO_REMOTE': '1', 10:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:14 INFO - 'NO_EM_RESTART': '1', 10:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:14 INFO - 'PWD': '/builds/slave/test', 10:07:14 INFO - 'SHELL': '/bin/bash', 10:07:14 INFO - 'SHLVL': '1', 10:07:14 INFO - 'TERM': 'linux', 10:07:14 INFO - 'TMOUT': '86400', 10:07:14 INFO - 'USER': 'cltbld', 10:07:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:14 INFO - '_': '/tools/buildbot/bin/python'} 10:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:16 INFO - Installing collected packages: mozsystemmonitor 10:07:16 INFO - Running setup.py install for mozsystemmonitor 10:07:17 INFO - Successfully installed mozsystemmonitor 10:07:17 INFO - Cleaning up... 10:07:17 INFO - Return code: 0 10:07:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:17 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')]} 10:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:17 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')]} 10:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:17 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:17 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 10:07:17 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 10:07:17 INFO - Using env: {'DISPLAY': ':0', 10:07:17 INFO - 'HOME': '/home/cltbld', 10:07:17 INFO - 'LANG': 'en_US.UTF-8', 10:07:17 INFO - 'LANGUAGE': 'en_US:en', 10:07:17 INFO - 'LOGNAME': 'cltbld', 10:07:17 INFO - 'MAIL': '/var/mail/cltbld', 10:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:17 INFO - 'MOZ_NO_REMOTE': '1', 10:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:17 INFO - 'NO_EM_RESTART': '1', 10:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:17 INFO - 'PWD': '/builds/slave/test', 10:07:17 INFO - 'SHELL': '/bin/bash', 10:07:17 INFO - 'SHLVL': '1', 10:07:17 INFO - 'TERM': 'linux', 10:07:17 INFO - 'TMOUT': '86400', 10:07:17 INFO - 'USER': 'cltbld', 10:07:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:17 INFO - '_': '/tools/buildbot/bin/python'} 10:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:17 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:19 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:19 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 10:07:20 INFO - Downloading docopt-0.6.1.tar.gz 10:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:20 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:20 INFO - Running setup.py install for blobuploader 10:07:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:20 INFO - Running setup.py install for requests 10:07:20 INFO - Running setup.py install for docopt 10:07:20 INFO - Successfully installed blobuploader requests docopt 10:07:20 INFO - Cleaning up... 10:07:20 INFO - Return code: 0 10:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:20 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')]} 10:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:20 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')]} 10:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:20 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:20 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 10:07:20 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 10:07:20 INFO - Using env: {'DISPLAY': ':0', 10:07:20 INFO - 'HOME': '/home/cltbld', 10:07:20 INFO - 'LANG': 'en_US.UTF-8', 10:07:20 INFO - 'LANGUAGE': 'en_US:en', 10:07:20 INFO - 'LOGNAME': 'cltbld', 10:07:20 INFO - 'MAIL': '/var/mail/cltbld', 10:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:20 INFO - 'MOZ_NO_REMOTE': '1', 10:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:20 INFO - 'NO_EM_RESTART': '1', 10:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:20 INFO - 'PWD': '/builds/slave/test', 10:07:20 INFO - 'SHELL': '/bin/bash', 10:07:20 INFO - 'SHLVL': '1', 10:07:20 INFO - 'TERM': 'linux', 10:07:20 INFO - 'TMOUT': '86400', 10:07:20 INFO - 'USER': 'cltbld', 10:07:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:20 INFO - '_': '/tools/buildbot/bin/python'} 10:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:21 INFO - Running setup.py (path:/tmp/pip-SGsv7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:21 INFO - Running setup.py (path:/tmp/pip-8uwPmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:21 INFO - Running setup.py (path:/tmp/pip-D8aAJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:21 INFO - Running setup.py (path:/tmp/pip-H5waon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:21 INFO - Running setup.py (path:/tmp/pip-ZoUrsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:21 INFO - Running setup.py (path:/tmp/pip-UYnT0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:21 INFO - Running setup.py (path:/tmp/pip-mtHyXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:21 INFO - Running setup.py (path:/tmp/pip-_HILen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:21 INFO - Running setup.py (path:/tmp/pip-oXXVP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:21 INFO - Running setup.py (path:/tmp/pip-Y_77hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:21 INFO - Running setup.py (path:/tmp/pip-Dlmp9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:21 INFO - Running setup.py (path:/tmp/pip-Db32xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:21 INFO - Running setup.py (path:/tmp/pip-SgiP41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:21 INFO - Running setup.py (path:/tmp/pip-Ra9Yv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:22 INFO - Running setup.py (path:/tmp/pip-LzT9By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:22 INFO - Running setup.py (path:/tmp/pip-niU272-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:22 INFO - Running setup.py (path:/tmp/pip-SAZGO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:22 INFO - Running setup.py install for manifestparser 10:07:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:22 INFO - Running setup.py install for mozcrash 10:07:22 INFO - Running setup.py install for mozdebug 10:07:22 INFO - Running setup.py install for mozdevice 10:07:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:07:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:22 INFO - Running setup.py install for mozfile 10:07:22 INFO - Running setup.py install for mozhttpd 10:07:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:22 INFO - Running setup.py install for mozinfo 10:07:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:22 INFO - Running setup.py install for mozInstall 10:07:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Running setup.py install for mozleak 10:07:23 INFO - Running setup.py install for mozlog 10:07:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Running setup.py install for moznetwork 10:07:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Running setup.py install for mozprocess 10:07:23 INFO - Running setup.py install for mozprofile 10:07:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Running setup.py install for mozrunner 10:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:23 INFO - Running setup.py install for mozscreenshot 10:07:23 INFO - Running setup.py install for moztest 10:07:23 INFO - Running setup.py install for mozversion 10:07:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:24 INFO - Cleaning up... 10:07:24 INFO - Return code: 0 10:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:24 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:24 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 10:07:24 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 10:07:24 INFO - Using env: {'DISPLAY': ':0', 10:07:24 INFO - 'HOME': '/home/cltbld', 10:07:24 INFO - 'LANG': 'en_US.UTF-8', 10:07:24 INFO - 'LANGUAGE': 'en_US:en', 10:07:24 INFO - 'LOGNAME': 'cltbld', 10:07:24 INFO - 'MAIL': '/var/mail/cltbld', 10:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:24 INFO - 'MOZ_NO_REMOTE': '1', 10:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:24 INFO - 'NO_EM_RESTART': '1', 10:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:24 INFO - 'PWD': '/builds/slave/test', 10:07:24 INFO - 'SHELL': '/bin/bash', 10:07:24 INFO - 'SHLVL': '1', 10:07:24 INFO - 'TERM': 'linux', 10:07:24 INFO - 'TMOUT': '86400', 10:07:24 INFO - 'USER': 'cltbld', 10:07:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:24 INFO - '_': '/tools/buildbot/bin/python'} 10:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:24 INFO - Running setup.py (path:/tmp/pip-Qtk8Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:24 INFO - Running setup.py (path:/tmp/pip-Xu0ObR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:24 INFO - Running setup.py (path:/tmp/pip-mN1whV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:24 INFO - Running setup.py (path:/tmp/pip-WqeF3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:24 INFO - Running setup.py (path:/tmp/pip-lwK6Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:24 INFO - Running setup.py (path:/tmp/pip-PdYEC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:24 INFO - Running setup.py (path:/tmp/pip-wYV5BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:24 INFO - Running setup.py (path:/tmp/pip-a6M0bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:24 INFO - Running setup.py (path:/tmp/pip-kShMkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:24 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)) 10:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:24 INFO - Running setup.py (path:/tmp/pip-3nOljC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:25 INFO - Running setup.py (path:/tmp/pip-7IDAAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:25 INFO - Running setup.py (path:/tmp/pip-YdYLpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:25 INFO - Running setup.py (path:/tmp/pip-SLnnNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:25 INFO - Running setup.py (path:/tmp/pip-OrJBRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:25 INFO - Running setup.py (path:/tmp/pip-7eWSoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:25 INFO - Running setup.py (path:/tmp/pip-iA5YYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:25 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)) 10:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:25 INFO - Running setup.py (path:/tmp/pip-t0Kqik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:25 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)) 10:07:25 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)) 10:07:25 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)) 10:07:25 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)) 10:07:25 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)) 10:07:25 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)) 10:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:27 INFO - Downloading blessings-1.6.tar.gz 10:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:27 INFO - Installing collected packages: blessings 10:07:27 INFO - Running setup.py install for blessings 10:07:27 INFO - Successfully installed blessings 10:07:27 INFO - Cleaning up... 10:07:27 INFO - Return code: 0 10:07:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:28 INFO - Reading from file tmpfile_stdout 10:07:28 INFO - Current package versions: 10:07:28 INFO - argparse == 1.2.1 10:07:28 INFO - blessings == 1.6 10:07:28 INFO - blobuploader == 1.2.4 10:07:28 INFO - docopt == 0.6.1 10:07:28 INFO - manifestparser == 1.1 10:07:28 INFO - mozInstall == 1.12 10:07:28 INFO - mozcrash == 0.17 10:07:28 INFO - mozdebug == 0.1 10:07:28 INFO - mozdevice == 0.48 10:07:28 INFO - mozfile == 1.2 10:07:28 INFO - mozhttpd == 0.7 10:07:28 INFO - mozinfo == 0.9 10:07:28 INFO - mozleak == 0.1 10:07:28 INFO - mozlog == 3.2 10:07:28 INFO - moznetwork == 0.27 10:07:28 INFO - mozprocess == 0.22 10:07:28 INFO - mozprofile == 0.28 10:07:28 INFO - mozrunner == 6.11 10:07:28 INFO - mozscreenshot == 0.1 10:07:28 INFO - mozsystemmonitor == 0.3 10:07:28 INFO - moztest == 0.7 10:07:28 INFO - mozversion == 1.4 10:07:28 INFO - psutil == 3.1.1 10:07:28 INFO - requests == 1.2.3 10:07:28 INFO - wsgiref == 0.1.2 10:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:28 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')]} 10:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:28 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')]} 10:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:28 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:28 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 10:07:28 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 10:07:28 INFO - Using env: {'DISPLAY': ':0', 10:07:28 INFO - 'HOME': '/home/cltbld', 10:07:28 INFO - 'LANG': 'en_US.UTF-8', 10:07:28 INFO - 'LANGUAGE': 'en_US:en', 10:07:28 INFO - 'LOGNAME': 'cltbld', 10:07:28 INFO - 'MAIL': '/var/mail/cltbld', 10:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:28 INFO - 'MOZ_NO_REMOTE': '1', 10:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:28 INFO - 'NO_EM_RESTART': '1', 10:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:28 INFO - 'PWD': '/builds/slave/test', 10:07:28 INFO - 'SHELL': '/bin/bash', 10:07:28 INFO - 'SHLVL': '1', 10:07:28 INFO - 'TERM': 'linux', 10:07:28 INFO - 'TMOUT': '86400', 10:07:28 INFO - 'USER': 'cltbld', 10:07:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:28 INFO - '_': '/tools/buildbot/bin/python'} 10:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 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)) 10:07:28 INFO - Cleaning up... 10:07:28 INFO - Return code: 0 10:07:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:28 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')]} 10:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:28 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')]} 10:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:28 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:28 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 10:07:28 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 10:07:28 INFO - Using env: {'DISPLAY': ':0', 10:07:28 INFO - 'HOME': '/home/cltbld', 10:07:28 INFO - 'LANG': 'en_US.UTF-8', 10:07:28 INFO - 'LANGUAGE': 'en_US:en', 10:07:28 INFO - 'LOGNAME': 'cltbld', 10:07:28 INFO - 'MAIL': '/var/mail/cltbld', 10:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:28 INFO - 'MOZ_NO_REMOTE': '1', 10:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:28 INFO - 'NO_EM_RESTART': '1', 10:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:28 INFO - 'PWD': '/builds/slave/test', 10:07:28 INFO - 'SHELL': '/bin/bash', 10:07:28 INFO - 'SHLVL': '1', 10:07:28 INFO - 'TERM': 'linux', 10:07:28 INFO - 'TMOUT': '86400', 10:07:28 INFO - 'USER': 'cltbld', 10:07:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:28 INFO - '_': '/tools/buildbot/bin/python'} 10:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:28 INFO - Downloading/unpacking jsonschema 10:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:30 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:30 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 10:07:30 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 10:07:30 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 10:07:30 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 10:07:30 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 10:07:30 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 10:07:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:30 INFO - warning: no files found matching '*.txt' 10:07:30 INFO - no previously-included directories found matching 'build' 10:07:30 INFO - no previously-included directories found matching 'dist' 10:07:30 INFO - no previously-included directories found matching '.git*' 10:07:30 INFO - Installing collected packages: jsonschema, functools32 10:07:30 INFO - Running setup.py install for functools32 10:07:30 INFO - warning: no files found matching '*.txt' 10:07:30 INFO - no previously-included directories found matching 'build' 10:07:30 INFO - no previously-included directories found matching 'dist' 10:07:30 INFO - no previously-included directories found matching '.git*' 10:07:30 INFO - Successfully installed jsonschema functools32 10:07:30 INFO - Cleaning up... 10:07:30 INFO - Return code: 0 10:07:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07:30 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')]} 10:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 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')]} 10:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:30 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 0x7f763bafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', '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 10:07:30 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 10:07:30 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 10:07:30 INFO - Using env: {'DISPLAY': ':0', 10:07:30 INFO - 'HOME': '/home/cltbld', 10:07:30 INFO - 'LANG': 'en_US.UTF-8', 10:07:30 INFO - 'LANGUAGE': 'en_US:en', 10:07:30 INFO - 'LOGNAME': 'cltbld', 10:07:30 INFO - 'MAIL': '/var/mail/cltbld', 10:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:30 INFO - 'MOZ_NO_REMOTE': '1', 10:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:30 INFO - 'NO_EM_RESTART': '1', 10:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:30 INFO - 'PWD': '/builds/slave/test', 10:07:30 INFO - 'SHELL': '/bin/bash', 10:07:30 INFO - 'SHLVL': '1', 10:07:30 INFO - 'TERM': 'linux', 10:07:30 INFO - 'TMOUT': '86400', 10:07:30 INFO - 'USER': 'cltbld', 10:07:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:30 INFO - '_': '/tools/buildbot/bin/python'} 10:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:31 INFO - Downloading/unpacking flake8 10:07:31 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 10:07:31 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 10:07:31 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 10:07:31 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 10:07:31 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 10:07:31 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 10:07:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:32 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 10:07:32 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 10:07:32 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 10:07:32 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 10:07:32 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 10:07:32 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 10:07:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 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 10:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:33 INFO - no previously-included directories found matching 'docs/_build' 10:07:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:33 INFO - Running setup.py install for pep8 10:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:33 INFO - no previously-included directories found matching 'docs/_build' 10:07:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:33 INFO - Cleaning up... 10:07:33 INFO - Return code: 0 10:07:33 INFO - Running post-action listener: _resource_record_post_action 10:07:33 INFO - Running post-action listener: _start_resource_monitoring 10:07:33 INFO - Starting resource monitoring. 10:07:33 INFO - ##### 10:07:33 INFO - ##### Finished create-virtualenv step (success) 10:07:33 INFO - ##### 10:07:33 INFO - ##### 10:07:33 INFO - ##### Running install step. 10:07:33 INFO - ##### 10:07:33 INFO - Running pre-action listener: _resource_record_pre_action 10:07:33 INFO - Running main action method: install 10:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:34 INFO - Reading from file tmpfile_stdout 10:07:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:34 INFO - Reading from file tmpfile_stdout 10:07:34 INFO - Output received: 10:07:34 INFO - Usage: mozinstall [options] installer 10:07:34 INFO - Options: 10:07:34 INFO - -h, --help show this help message and exit 10:07:34 INFO - -d DEST, --destination=DEST 10:07:34 INFO - Directory to install application into. [default: 10:07:34 INFO - "/builds/slave/test"] 10:07:34 INFO - --app=APP Application being installed. [default: firefox] 10:07:34 INFO - mkdir: /builds/slave/test/build/application 10:07:34 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'] 10:07:34 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 10:07:50 INFO - Reading from file tmpfile_stdout 10:07:50 INFO - Output received: 10:07:50 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:50 INFO - Running post-action listener: _resource_record_post_action 10:07:50 INFO - ##### 10:07:50 INFO - ##### Finished install step (success) 10:07:50 INFO - ##### 10:07:50 INFO - ##### 10:07:50 INFO - ##### Running run-tests step. 10:07:50 INFO - ##### 10:07:50 INFO - Running pre-action listener: _resource_record_pre_action 10:07:50 INFO - Running main action method: run_tests 10:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:50 INFO - Python 2.7.3 10:07:50 INFO - Return code: 0 10:07:50 INFO - grabbing minidump binary from tooltool 10:07: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')]} 10:07:50 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 0x142a9c0>, '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 0x142b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:50 INFO - Return code: 0 10:07:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:51 INFO - Return code: 0 10:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 10:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 10:07:51 INFO - Using env: {'DISPLAY': ':0', 10:07:51 INFO - 'HOME': '/home/cltbld', 10:07:51 INFO - 'LANG': 'en_US.UTF-8', 10:07:51 INFO - 'LANGUAGE': 'en_US:en', 10:07:51 INFO - 'LOGNAME': 'cltbld', 10:07:51 INFO - 'MAIL': '/var/mail/cltbld', 10:07:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:51 INFO - 'MOZ_NO_REMOTE': '1', 10:07:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:51 INFO - 'NO_EM_RESTART': '1', 10:07:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:51 INFO - 'PWD': '/builds/slave/test', 10:07:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:51 INFO - 'SHELL': '/bin/bash', 10:07:51 INFO - 'SHLVL': '1', 10:07:51 INFO - 'TERM': 'linux', 10:07:51 INFO - 'TMOUT': '86400', 10:07:51 INFO - 'USER': 'cltbld', 10:07:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298', 10:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:51 INFO - '_': '/tools/buildbot/bin/python'} 10:07:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 10:07:52 INFO - mozversion application_buildid: 20160524073032 10:07:52 INFO - mozversion application_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 10:07:52 INFO - mozversion application_display_name: Nightly 10:07:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:52 INFO - mozversion application_name: Firefox 10:07:52 INFO - mozversion application_remotingname: firefox 10:07:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:52 INFO - mozversion application_vendor: Mozilla 10:07:52 INFO - mozversion application_version: 49.0a1 10:07:52 INFO - mozversion platform_buildid: 20160524073032 10:07:52 INFO - mozversion platform_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 10:07:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:52 INFO - mozversion platform_version: 49.0a1 10:07:52 INFO - using testdate: 1464109672 10:07:52 INFO - actual date: 1464109672 10:07:52 INFO - starting webserver on 'localhost:45835' 10:07:52 INFO - SUITE-START | Running 2 tests 10:07:52 INFO - TEST-START | dromaeo_css 10:07:52 INFO - operating with platform_type : linux_ 10:07:52 INFO - Initialising browser for dromaeo_css test... 10:07:52 INFO - TEST-INFO | started process 4774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Jz7hw/profile http://localhost:45835/getInfo.html) 10:07:55 INFO - PROCESS | 4774 | 10:07:55 INFO - PROCESS | 4774 | (process:4843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:56 INFO - PROCESS | 4774 | __metrics Screen width/height:1600/1200 10:07:56 INFO - PROCESS | 4774 | colorDepth:24 10:07:56 INFO - PROCESS | 4774 | Browser inner width/height: 1024/697 10:07:56 INFO - PROCESS | 4774 | __metrics 10:07:57 ERROR - PROCESS | 4774 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:07:58 INFO - TEST-INFO | 4774: exit 0 10:07:58 INFO - Browser initialized. 10:07:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:58 INFO - TEST-INFO | started process 4894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Jz7hw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:00 INFO - PROCESS | 4894 | 10:08:00 INFO - PROCESS | 4894 | (process:4956): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:08:10 INFO - PROCESS | 4894 | RSS: Main: 164102144 10:08:10 INFO - PROCESS | 4894 | 10:08:59 INFO - PROCESS | 4894 | 1464109739671 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] 10:11:07 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45835/tests/dromaeo/cssquery-ext.html) 10:11:08 INFO - PROCESS | 4894 | RSS: Main: 167018496 10:11:08 INFO - PROCESS | 4894 | 10:14:10 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-ext.html (next: http://localhost:45835/tests/dromaeo/cssquery-jquery.html) 10:14:10 INFO - PROCESS | 4894 | RSS: Main: 167010304 10:14:10 INFO - PROCESS | 4894 | 10:17:12 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45835/tests/dromaeo/cssquery-mootools.html) 10:17:13 INFO - PROCESS | 4894 | RSS: Main: 168255488 10:17:13 INFO - PROCESS | 4894 | 10:20:14 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45835/tests/dromaeo/cssquery-prototype.html) 10:20:15 INFO - PROCESS | 4894 | RSS: Main: 166547456 10:20:15 INFO - PROCESS | 4894 | 10:23:18 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45835/tests/dromaeo/cssquery-yui.html) 10:23:18 INFO - PROCESS | 4894 | RSS: Main: 167403520 10:23:18 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:45835/tests/dromaeo/cssquery-yui.html (next: http://localhost:45835/tests/dromaeo/cssquery-dojo.html) 10:26:21 INFO - PROCESS | 4894 | RSS: Main: 169218048 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | __start_tp_report 10:26:21 INFO - PROCESS | 4894 | _x_x_mozilla_page_load 10:26:21 INFO - PROCESS | 4894 | _x_x_mozilla_page_load_details 10:26:21 INFO - PROCESS | 4894 | |i|pagename|runs| 10:26:21 INFO - PROCESS | 4894 | |0;dojo.html;3111.3621707549955;3147.543606177103;3165.986884197057;3181.5704879841214;3193.8722451101958;5462.78148874045;5507.834764957052;5523.4476552344795;5568.470995255454;5602.60781745278;5309.442508536606;5346.893062138755;5359.866003349908;5480.342358916935;5564.916526252099;4988.476209997962;5016.548510634042;5052.974735126338;5088.771005304751;5146.228065790124;600.3514185191241;5043.974780126113;5162.328897243353;5182.067227898977;5191.610629202806;5024.648274620797;5028.069807085701;5037.924431133536;5069.2649565812935;5083.262926875619;5022.824201152978;5027.044861476308;5035.924461133086;5058.291839142523;5090.898182036375;4916.213405855046;4941.258811178352;4963.503649635044;4976.726280054596;4995.650304478688;5354.812581559666;5415.48552887479;5417.891642167174;5443.59173062018;5481.862953426156;5814.389489103625;5861.6483011019045;5873.735681894325;5882.47057764799;5885.352611212763;5653.519450846683;5705.486506214461;5721.284839395075;5748.683822389767;5923.674197919113;5305.495977882095;5338.572914166896;5346.572274218053;5350.705711185883;5374.6237763356585;5879.265091863517;5883.705814709333;5890.558208134407;5912.260967379078;5927.585069045125;5626.718664066781;5637.661740295595;5659.915101273484;5677.148427735872;5725.942740572541;5801.129830525455;5816.82549523515;5832.066869300891;5839.678817664984;5839.678817665069;5691.943080569225;5740.942590574041;5784.305883294031;5809.2738407699035;5831.88336233273;5773.39379365169;5837.270341207349;5880.882632299849;5916.852078698067;5918.526517878559;4371.540988196193;4414.492333381702;4445.799939002753;4445.844395446144;4479.932801007987;3975;3996.440498330236;4000.299947509174;4017.216642754635;4026.315526360526;5502.614816962774;5600.635958662674;5654.491095801398;5712.885742285131;5740.110282906073;5954.07711804671;5972.820815375546;5984.072468767348;5995.400459953969;6002.579819412686;5481.75332110056;5711.657300561979;5723.341815691166;5729.455701708331;5735.738137609719;4898.632602554822;4926.285688575136;4934.087193869145;4939.506049395103;4955.529224723646;6148.1699970504305;6170.475509581646;6172.938270617326;6183.536234782409;6187.597806142587;5689.743961521659;5753.568482363756;5968.641881487125;5968.910466343008;5972.163897054415;5933.881322373615;5950.9702451487465;5971.4327138921735;5982.880342393215;6041.969790151021;5665.716714164358;5668.404817494269;5670.206171136127;5679.829605111853;5710.828675139753;5730.08318669011;5773.134029895549;5795.188673585786;5802.245708057925;5867.853303667443;5723.313202415737;5725.055365864586;5730.541556675373;5731.627444216113;5759.308882933907;5654.3497497788285;5685.943140568541;5718.428157184248;5739.827805165852;5752.050911599539;5516.668999860021;5607.327120745536;5621.044422448112;5635.323761148688;5684.431556844283;5608.298962629671;5772.422757724362;5786.450287222707;5816.447437493432;5857.121431785266;5698.6580805151825;5758.424157584208;5759.049756790083;5766.769329226784;5781.595288329777 10:26:21 INFO - PROCESS | 4894 | |1;ext.html;553.6346011632321;594.8780499997501;604.4892066204056;608.9878202435954;615.3446579392948;40986.97532561684;41849.58150418495;41974.58025419745;42059.36910946338;45222.32166517505;39779;39914;40024.599754002455;40200.59799402005;40437.797811010976;8637.0499245083;8849.601767920427;8853.5573221339;8856.247218986362;8885.95557022214;8635.179657932518;8739.781505462382;8742.737717868475;8747.912520874774;8748.475091494498;8807.603657835381;8829.293656507463;8835.77910552235;8852.778680533005;8869.512176830272;8674.86987695185;8709.56452177395;8746.34402419821;8751;8761.737147885542;8630.309575234029;8679.609417576161;8715.782105447352;8729.60716767747;8749.343799215085;41494.37758433626;41535;41654.583454165375;41843.790781046206;41919;3748.775073495599;3752.605976372496;3766.9811650941842;4165.146145040259;4329.631981281595;31694.841525792224;31920.840395798106;32446.837765811255;32447;33317.666823331696;3800.9429858552144;3857.4213867919757;3862.478565393664;3888.552816426119;3967.6230758077936;330345;334092;334209;334704;335803;55476;55787.72106139443;55841.72079139578;55958.44041559614;56016.71991640016;35821.41785821449;36501.26997460036;36680.63319366772;38483.80758096192;58771.70614146988;16280.185990700418;16400.425985090704;16505.752413713803;16551.172441377883;16561.17194140288;12603.117781755373;12609;12628;12629.810552841715;12639.368031598384;18670.53323666919;18693.813061869478;18847.151878165514;18990.525236869187;19046.428607141806;6858.177018757781;6954.547954382949;6965.930340696629;7151.392131668762;7329.74345897891;994.7165057958447;1060.2419270221828;1076.214363514623;1104.2938659770514;1200.6338066889507;31795.36409271848;32417.35165296681;32557.83721081427;33001.339973200884;35420.82289588536;1043.1967385113421;1141.9429028548539;1143.731223162556;1173.7711146326556;1254.4793910527028;16646.334146634243;17153;17295.913520432317;17351.56621084483;17351.826481735272;477209;488699;488828;491377;493736;58665.70667146637;58881.70559147177;59157;59292.70353648204;59692.40307596955;1356.504875720355;1415.2994267837487;1425.2232533269394;1435.411481292665;1444.8916331274986;31750.841245793625;32424.83787581047;32659.673403265664;32850.671493285714;32949.341013179124;51993.48006519886;52312.738436307576;52624.473755261955;52698.47301526936;52723.20915186352;353642;356197;356207;357059;357415;42951.14097717965;43543.56456435522;45693.771531142134;46819.29771053505;47835;47320.763396182796;49888;50068.749656251486;51009.489905100476;51034.234486483474;41917;43142;43184.13631727285;43454.34818477662;44288.4499042532;42330.1533969325;42634.57365426306;42637.786811065744;42768.78615606902;43167.56832431635;43212;44732.10535789331;45335.31997020113;45675.31487027764;45898.77050614726;39655.80172099121;40597.1880562393;41344;42089.36865946952;42579.361309581;34046;34497.827510862284;34572;34689.65310346864;34767.82616086904 10:26:21 INFO - PROCESS | 4894 | |2;jquery.html;359.85965473465336;365.43357795417097;369.5620689482962;378.402124643064;379.00889174807867;17720.291188352465;19279.518012049706;19443.902780486114;20121.496962575926;20122.59754804903;18498.630027399446;18906.149223284952;19304.613907721836;19320.51698707533;19370.51573710658;5404.945950540484;5481.99999999999;5649.1526271059465;5675.177099320596;5682.943170568283;5529.917051244234;5588.133839254901;5605.607607467479;5621.072523033695;5646.717664116778;5109.540141387274;5569.805056823012;5572.5263352615075;5581.358143813472;5582.720863956806;5378.031954248234;5437.238786569844;5445.618806683534;5475.616706830523;5489.4236105208975;5180.5337519623035;5617.719114044322;5635.1828984796975;5639.943600563983;5655.3779084300695;11215.158863085302;11295.096392288597;11358.148138889534;12160.574379896749;14096.647583810487;2123.3629911026783;2227.175944900381;2267.7958983691547;2314.7916687498205;2488;9740.610375584969;9984.950075249577;10287.897121028844;11294.604688835934;14073.522280160538;1870.4669169286688;1899.1264018551483;1940.4566721318054;2005.5487515309085;2028.3103744726864;72721;74759.25240747632;74963.25036749672;83591.16408835955;88218.55890720569;10485.737856553647;10917.39954302521;11008.009279164913;11070.833937490945;11151.776964460827;15123.092614443169;15177.848221517865;15251.313690883937;15258.923705381623;15263.08421494714;8142.837143257102;8186.7953301167945;8215.917840821516;8260.752177434686;8342.582870856433;7772.805679858049;7807.726729564438;7925.326347260432;7967.880481792778;7991.200879912079;4534.79593418297;4706.176419126639;4718.103560323528;4768.332433459318;4827.155247831615;1855.2949879046146;1907.2943011085988;1907.399169261678;1907.7424547685885;1991.2831380702935;934.2619330728784;1028.377831412;1040.107005250437;1073.538378497238;1098.752780624369;18533.721994170097;19036.238550457827;19188.71216931747;19275.710864337045;19365.225390984204;972.3873959405671;998.1565577087349;1032.932859364154;1039.7816458543791;1082.1396989393452;10446.529906154241;10823.296485728402;10888.40113793749;10941.945290273497;10950.835737463944;416264.9186754047;418607;462488;470150;473500;78834;86475.56762216275;87675;92797;99755;1043.8642976413018;1059.7933402986343;1076.3541874875011;1085.0993675249524;1086.1419478611965;15795.605109872346;17151.228194731517;17319.220635071702;17401.303947841945;17520.561985950455;32002.83998579992;38183.04542386463;39802.60197397989;40864;45095;58745.11882321683;60050.099248510436;60822;61226.387736122066;61312.386876132456;7803.531788092732;8190.385721070825;8193.262606365455;8284.83430331402;8425.789355266168;9116.4074335168;11176.16178786578;12485.250884946932;13187.60437186886;13200.14199077057;10750.247482676137;10804.40575768309;10824.945875270574;10922;11003.184713375605;10181.592736290466;10545.789084218426;10651.254412191382;10763.192760543147;10977.28647637901;6760;10476.63331783384;10707.143428525544;11054.281471704313;11342.035926946302;7889.447738658238;7889.6449659766595;7904.960475197818;8008.199180081945;8021.358291336563;9624.278179136452;10326.173906087344;10481.528331224961;10519.631812886511;10635.415052172204 10:26:21 INFO - PROCESS | 4894 | |3;mootools.html;1532.3181184372954;1554.712378210031;1703.4804384662673;1835.9902053870385;1847.362659882341;8151.103378628361;8421.70524031659;8815.911840881588;9373.953130234348;9375.531223438826;8427.199416055464;8490.448120872139;8500.362472814548;8541.188587084218;8572.271356934669;2325.6162733149054;2364.4443555764383;2365.95268094638;2366.183666635017;2366.692329997098;2283.8515496492673;2309.642005489152;2320.176337400224;2328.080408238745;2342.9882850585723;2250.4711392822674;2253.3352660965056;2255.154317131076;2325.1164557468223;2326.523062772136;2332.195392589554;2352.3060697094397;2364.0780095762666;2367.2661474942824;2370.9051637934463;2341.1922886604093;2356.787889089973;2369.040538581877;2369.7748713872156;2376.65538496917;8558.186972237627;8637.179467950535;8644.227933273663;8645.265152462049;8648.351373647001;5180.585553155738;5278.102722537178;5342.225377320306;5430.8913821723345;5483.561315094783;3351.128706536318;3398.8130652814084;3432.5366075579977;3434.6565343465704;3451.741119416054;1049.3703777733376;1069.7860427914447;1070.689500044986;1082.426314053545;1092.6831218946495;12880.162789418659;12896.935515322457;12929;12967.935160324232;12971.221726696429;4694.694844835075;4694.788734506956;4967.379077615298;4980.8754781130765;4992.525710057539;10743.194260430499;10801.513931872927;10877.728056798644;10908.181886358554;10968.890311096946;5407.567394608422;5409.404965453797;5423.213634023124;5467.726613669301;5497.505224529811;4349.238883195429;4833.492483289274;4928.359313289249;4969.2546118081855;5014.548690617862;3954.584768599313;3962.425448309979;4037.6971727120585;4105.8973525662095;4116.073883376216;1182.485618755844;1204.1631066408936;1277.2719549856492;1283.640580637423;1286.7619490394306;898.3486971945288;991.8908920018793;1015.3907655406697;1026.2662196529518;1029.1509504658536;6332.1135041094285;6378.2346118466085;6379.744810207632;6412.487001039905;6445.291017988017;461.1284671969979;464.3615029334665;472.15719939907103;476.1072988147224;480.0183624487931;4276.144771045803;4332.393464914914;4406.581374769392;4427.380166776589;4456.242438785414;11244.437778111062;11537.250078744855;11609.419529023515;11637.418129093512;11712.88287117135;10872.945635271773;11497.770044599061;11548.076153907667;11552.133589980785;11573.826392604118;8457.281131103926;8520.829583408296;8568.357373197035;8652.8702069469;8700.956495217484;6198.659073750807;6302.464290535356;6336.7465301389275;6381.202349706286;6447.6453795041725;9430.434173949585;10575.735606609589;10595.735106622396;10615.1507879371;10668.1998850085;9883.01169883006;9979.401235925867;10063.345882517613;10136.543855526372;10164.288499805238;7057.576545407292;7602.657880395285;7855.214478552099;7882.330001949898;8042.638081286239;8602.78493037679;8617.95691021541;8623.913760862311;8682;8697.173768491983;7712.652930618248;7877.724279650185;7972.2824945755165;8065.596720163851;8076.757697269091;7312.19565847767;7524.17234104259;7614.200508946481;7700.768976930701;7889.84220315579;6898.103246577913;7053.647317633995;7071.5049946505305;7077.363037326665;7087.362137407658;5204.921926171186;5368.302120724281;5454.154606036071;5510.586705997146;5519.034169020486;5542.750576223999;5625.212470254086;5627.803026894039;5673.8297851064535;5733.569982251432 10:26:21 INFO - PROCESS | 4894 | |4;prototype.html;309.3241267829792;311.83161093009767;316.8304956848087;322.4212538493404;323.4517492849621;5586.301712285965;5587.441255874415;5601.327840659126;5609.298837645294;5629.718514074295;5505.862353441166;5540.473655002778;5544.306961629796;5566.805161819337;5611.579131565129;4072.3484242521126;4206.20082184384;4225.302825033866;4252.468441444819;4294.67789915756;4290.163418133465;4292.227399068166;4299.677524185683;4309.008927946574;4318.82724691012;4231.619154276114;4250.128723611652;4256.59562341577;4259.212045771542;4270.487541495009;4080.6123418275365;4268.701190916637;4269.786510674485;4276.657867370603;4278.786060696968;3738.6261373862667;3745.7190710696805;3764.247150569897;3771.358868992278;3773.2264885698364;5277.944411117792;5346.812861549866;5379.973100134474;5398.8920221595345;5412.675239485643;4582.885427864297;4867.342908707315;4882.731449770261;4948.7278199699;4975.203967365204;5750.252467179282;5752.971235143839;5758.48173664368;5777.5666824987875;5785.450382213683;4062.634362907323;4071.491063617048;4087.2438598859308;4092.9795351023054;4094.467719196515;5947.4052594740615;6047.425494578052;6049.637021778663;6090.665013424215;6102.72537735803;4138.379243113557;4150.813213405404;4169.249535083714;4248.91502169961;4258.276093064186;4269.807858646368;4273.658107351404;4280.850170244026;4336.002719374498;4337;4695.624350052056;4880.682755620874;4881.829135980223;4958.677685950402;4959.578435832923;5843.217818565294;5856.4143585641095;5878.911816322759;5915.526757859361;5927.229460170151;1478.8595083467053;1483.3843954758654;1483.562349107016;1487.6280929767559;1495.7307684616655;942.4345392764286;943.8725772020827;951.1012093571646;958.9328746987784;965.1699538396973;5497.9828731684765;5615.298087739033;5616.354119276254;5662.886742265214;5715.599908006483;5898.436914217736;5924.052151655715;5949.393663710774;5952.196453478811;6020.187274717945;5331;5541.806036788693;5547.861303467364;5567.137093750475;5578.191162281528;3105.261053809874;3169.6513383527795;3169.968300316967;3212.229065024424;3226.467632840602;5853.765849365977;6088.695565221721;6130.785422510191;6138.355472675394;6144.662043587646;5985.581009329305;6011.699415029231;6015.819525414245;6020.397960203944;6049;6068.696565171724;6101.871153836554;6102.847428814315;6112.297085835097;6113.8471538211015;5834.329052158886;5899.144624029406;5936.525077993837;5963.194968679173;5964.165016897551;5801.796937107181;5857.736401861841;5861.912071318849;5869.6771677558145;5879.559033072451;5793.9860524408905;6052.273727152769;6105.389461053859;6107.114468402146;6143.754249829957;4068.0033391819193;4077.612626800449;4081;4106.733062350938;4141.130362623882;5654.85862853432;5931.970340148272;5951.464368206882;5957.255343082114;5963.254593175853;5758.971205143947;5805.361410244954;5864.501517371071;5867.383924688017;5888.998870192163;5772.913406298825;5781.831813070099;5782.595218334676;5790.449907258803;5908.970455147697;5525.751341189576;5684.459976302244;5689.431056894277;5706.3152421709665;5726.284214473191;5796.652200867961;5826.970865145647;5833.854153646023;5839.562032847638;5841.561882858718;5396.028714831211;5645.943540564542;5678.829635110953;5687.260656114679;5784.595078344475 10:26:21 INFO - PROCESS | 4894 | |5;yui.html;805.5408417202195;814.3241109878801;825.372716735281;827.6110228192755;842.2461896602541;13499.122557033787;13882.58352249433;14338.641533961656;14371.92814035931;14373;13676.452941882313;13722.1080629759;13795.793063104036;13809.24049177295;13839.93080034601;670.088679396021;780.8555417247799;790.2532107158723;800.5796956597775;804.4288555125838;795.2484901767832;796.1481215099845;796.8485987662326;797.6330887791594;798.6885114805231;844.5059640110512;846.9618867150962;847.5931552854634;848.2238751542332;852.8891244138254;840.3529282452508;844.3456321350972;846.6317152038882;847.2459511035183;848.240824462106;609.1958614628692;611.3855575146994;614.2720875762236;614.342653360904;615.9568830181889;13641;13675.452981880713;13695.589132326046;13699.657508562266;13719;13873.09824861391;13951.232682202475;13956;13973.371198296;14089.15465072099;10531.26281160319;10545.630902918438;10607.734806629896;10686;10826.783464330669;3745.4381842723537;3765.443426593177;3797.8697052266534;3827.8468861245797;3945.5462621798574;63558.68220658913;63805.361946380406;64345.67827160928;64863.70272594569;65354.3464565353;10843.349399036084;10916.836247456295;10933.671989840317;10966.725831854268;11041.171912106623;20179.899100504696;20236.797632023787;20252.18991240363;20255.59488810245;20373.08321125553;8126.228008339198;8183.754487365389;8206.22040906113;8252.876206856901;8543.401961862734;4800.543948324904;4835.830745923946;4883.560479556786;4896.4124305083615;4984.651074424828;3437.4671925851535;3536.717062634983;3546.6453354664327;3549.680528752425;3549.94675079874;606.0727087556046;612.10326871134;616.1220261127964;631.6368088349218;636.7612145445459;681.6455443169524;765.950213236149;777.5645638442377;787.9527228366317;818.7216346442119;8814.86777698335;8946.418482798597;8961.641534338683;9109.726708198765;9377.390469619453;776.3827756933251;785.658238666182;792.5244853088217;796.2634563029175;802.9598520073973;4393.7758144233885;4441.489228738672;4484;4487.349334346502;4578.427696537933;72468;72993.6350318245;73498.63250683712;73671.26328736644;74763;64831;65350.67324663441;65447.345526545076;65839.01241481381;67922.30194245183;59116;59373.10940335898;59716.40283597195;60020.399796002355;61286.69356653188;8584.029688974912;8624.396292259482;8649.740507784776;8708.390412671306;8894.688685895962;38727.03182420462;38771.41842872303;39716.02839716121;39905;40335.596644034355;43581.78209109061;46233;47697;48569.75715121402;54192.72903635457;10950.780984380428;11588.884111159117;11750.29498230109;12099.455524501594;12253.387330633255;13621.863781362059;13758.724825503634;13965.221553065277;14163.929180354033;14261.500847470288;12412.689682757642;13000.628647516707;13476;13644.317784110954;13853.861461385257;12807.743845122859;12845.550405735754;13061.608151755463;13573.04988650785;13593.11644743128;12652.430640621378;12898.742025159632;12926.547570834975;13072.084954053125;13085.280309583064;10254.436006019741;10429.634962776267;10832.350058996486;11003.449827508754;11080.224384293022;10820.296680716043;11136;11146.721331966766;11272.774544509228;11282.94358528235 10:26:21 INFO - PROCESS | 4894 | __end_tp_report 10:26:21 INFO - PROCESS | 4894 | __start_cc_report 10:26:21 INFO - PROCESS | 4894 | _x_x_mozilla_cycle_collect,337 10:26:21 INFO - PROCESS | 4894 | __end_cc_report 10:26:21 INFO - PROCESS | 4894 | __startTimestamp1464110781687__endTimestamp 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | ------- Summary: start ------- 10:26:21 INFO - PROCESS | 4894 | Number of tests: 6 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#0] dojo.html Cycles:165 Average:5412.04 Median:5679.83 stddev:720.23 (12.7%) stddev-sans-first:699.46 10:26:21 INFO - PROCESS | 4894 | Values: 3111.4 3147.5 3166.0 3181.6 3193.9 5462.8 5507.8 5523.4 5568.5 5602.6 5309.4 5346.9 5359.9 5480.3 5564.9 4988.5 5016.5 5053.0 5088.8 5146.2 600.4 5044.0 5162.3 5182.1 5191.6 5024.6 5028.1 5037.9 5069.3 5083.3 5022.8 5027.0 5035.9 5058.3 5090.9 4916.2 4941.3 4963.5 4976.7 4995.7 5354.8 5415.5 5417.9 5443.6 5481.9 5814.4 5861.6 5873.7 5882.5 5885.4 5653.5 5705.5 5721.3 5748.7 5923.7 5305.5 5338.6 5346.6 5350.7 5374.6 5879.3 5883.7 5890.6 5912.3 5927.6 5626.7 5637.7 5659.9 5677.1 5725.9 5801.1 5816.8 5832.1 5839.7 5839.7 5691.9 5740.9 5784.3 5809.3 5831.9 5773.4 5837.3 5880.9 5916.9 5918.5 4371.5 4414.5 4445.8 4445.8 4479.9 3975.0 3996.4 4000.3 4017.2 4026.3 5502.6 5600.6 5654.5 5712.9 5740.1 5954.1 5972.8 5984.1 5995.4 6002.6 5481.8 5711.7 5723.3 5729.5 5735.7 4898.6 4926.3 4934.1 4939.5 4955.5 6148.2 6170.5 6172.9 6183.5 6187.6 5689.7 5753.6 5968.6 5968.9 5972.2 5933.9 5951.0 5971.4 5982.9 6042.0 5665.7 5668.4 5670.2 5679.8 5710.8 5730.1 5773.1 5795.2 5802.2 5867.9 5723.3 5725.1 5730.5 5731.6 5759.3 5654.3 5685.9 5718.4 5739.8 5752.1 5516.7 5607.3 5621.0 5635.3 5684.4 5608.3 5772.4 5786.5 5816.4 5857.1 5698.7 5758.4 5759.0 5766.8 5781.6 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#1] ext.html Cycles:180 Average:56627.66 Median:41883.29 stddev:105062.01 (250.8%) stddev-sans-first:105272.38 10:26:21 INFO - PROCESS | 4894 | Values: 553.6 594.9 604.5 609.0 615.3 40987.0 41849.6 41974.6 42059.4 45222.3 39779.0 39914.0 40024.6 40200.6 40437.8 8637.0 8849.6 8853.6 8856.2 8886.0 8635.2 8739.8 8742.7 8747.9 8748.5 8807.6 8829.3 8835.8 8852.8 8869.5 8674.9 8709.6 8746.3 8751.0 8761.7 8630.3 8679.6 8715.8 8729.6 8749.3 41494.4 41535.0 41654.6 41843.8 41919.0 3748.8 3752.6 3767.0 4165.1 4329.6 31694.8 31920.8 32446.8 32447.0 33317.7 3800.9 3857.4 3862.5 3888.6 3967.6 330345.0 334092.0 334209.0 334704.0 335803.0 55476.0 55787.7 55841.7 55958.4 56016.7 35821.4 36501.3 36680.6 38483.8 58771.7 16280.2 16400.4 16505.8 16551.2 16561.2 12603.1 12609.0 12628.0 12629.8 12639.4 18670.5 18693.8 18847.2 18990.5 19046.4 6858.2 6954.5 6965.9 7151.4 7329.7 994.7 1060.2 1076.2 1104.3 1200.6 31795.4 32417.4 32557.8 33001.3 35420.8 1043.2 1141.9 1143.7 1173.8 1254.5 16646.3 17153.0 17295.9 17351.6 17351.8 477209.0 488699.0 488828.0 491377.0 493736.0 58665.7 58881.7 59157.0 59292.7 59692.4 1356.5 1415.3 1425.2 1435.4 1444.9 31750.8 32424.8 32659.7 32850.7 32949.3 51993.5 52312.7 52624.5 52698.5 52723.2 353642.0 356197.0 356207.0 357059.0 357415.0 42951.1 43543.6 45693.8 46819.3 47835.0 47320.8 49888.0 50068.7 51009.5 51034.2 41917.0 43142.0 43184.1 43454.3 44288.4 42330.2 42634.6 42637.8 42768.8 43167.6 43212.0 44732.1 45335.3 45675.3 45898.8 39655.8 40597.2 41344.0 42089.4 42579.4 34046.0 34497.8 34572.0 34689.7 34767.8 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#2] jquery.html Cycles:180 Average:27175.75 Median:2401.40 stddev:74286.01 (3093.5%) stddev-sans-first:74467.12 10:26:21 INFO - PROCESS | 4894 | Values: 359.9 365.4 369.6 378.4 379.0 17720.3 19279.5 19443.9 20121.5 20122.6 18498.6 18906.1 19304.6 19320.5 19370.5 5404.9 5482.0 5649.2 5675.2 5682.9 5529.9 5588.1 5605.6 5621.1 5646.7 5109.5 5569.8 5572.5 5581.4 5582.7 5378.0 5437.2 5445.6 5475.6 5489.4 5180.5 5617.7 5635.2 5639.9 5655.4 11215.2 11295.1 11358.1 12160.6 14096.6 2123.4 2227.2 2267.8 2314.8 2488.0 9740.6 9985.0 10287.9 11294.6 14073.5 1870.5 1899.1 1940.5 2005.5 2028.3 72721.0 74759.3 74963.3 83591.2 88218.6 10485.7 10917.4 11008.0 11070.8 11151.8 15123.1 15177.8 15251.3 15258.9 15263.1 8142.8 8186.8 8215.9 8260.8 8342.6 7772.8 7807.7 7925.3 7967.9 7991.2 4534.8 4706.2 4718.1 4768.3 4827.2 1855.3 1907.3 1907.4 1907.7 1991.3 934.3 1028.4 1040.1 1073.5 1098.8 18533.7 19036.2 19188.7 19275.7 19365.2 972.4 998.2 1032.9 1039.8 1082.1 10446.5 10823.3 10888.4 10941.9 10950.8 416264.9 418607.0 462488.0 470150.0 473500.0 78834.0 86475.6 87675.0 92797.0 99755.0 1043.9 1059.8 1076.4 1085.1 1086.1 15795.6 17151.2 17319.2 17401.3 17520.6 32002.8 38183.0 39802.6 40864.0 45095.0 58745.1 60050.1 60822.0 61226.4 61312.4 7803.5 8190.4 8193.3 8284.8 8425.8 9116.4 11176.2 12485.3 13187.6 13200.1 10750.2 10804.4 10824.9 10922.0 11003.2 10181.6 10545.8 10651.3 10763.2 10977.3 6760.0 10476.6 10707.1 11054.3 11342.0 7889.4 7889.6 7905.0 8008.2 8021.4 9624.3 10326.2 10481.5 10519.6 10635.4 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#3] mootools.html Cycles:180 Average:5940.45 Median:474.13 stddev:3419.65 (721.2%) stddev-sans-first:3413.20 10:26:21 INFO - PROCESS | 4894 | Values: 1532.3 1554.7 1703.5 1836.0 1847.4 8151.1 8421.7 8815.9 9374.0 9375.5 8427.2 8490.4 8500.4 8541.2 8572.3 2325.6 2364.4 2366.0 2366.2 2366.7 2283.9 2309.6 2320.2 2328.1 2343.0 2250.5 2253.3 2255.2 2325.1 2326.5 2332.2 2352.3 2364.1 2367.3 2370.9 2341.2 2356.8 2369.0 2369.8 2376.7 8558.2 8637.2 8644.2 8645.3 8648.4 5180.6 5278.1 5342.2 5430.9 5483.6 3351.1 3398.8 3432.5 3434.7 3451.7 1049.4 1069.8 1070.7 1082.4 1092.7 12880.2 12896.9 12929.0 12967.9 12971.2 4694.7 4694.8 4967.4 4980.9 4992.5 10743.2 10801.5 10877.7 10908.2 10968.9 5407.6 5409.4 5423.2 5467.7 5497.5 4349.2 4833.5 4928.4 4969.3 5014.5 3954.6 3962.4 4037.7 4105.9 4116.1 1182.5 1204.2 1277.3 1283.6 1286.8 898.3 991.9 1015.4 1026.3 1029.2 6332.1 6378.2 6379.7 6412.5 6445.3 461.1 464.4 472.2 476.1 480.0 4276.1 4332.4 4406.6 4427.4 4456.2 11244.4 11537.3 11609.4 11637.4 11712.9 10872.9 11497.8 11548.1 11552.1 11573.8 8457.3 8520.8 8568.4 8652.9 8701.0 6198.7 6302.5 6336.7 6381.2 6447.6 9430.4 10575.7 10595.7 10615.2 10668.2 9883.0 9979.4 10063.3 10136.5 10164.3 7057.6 7602.7 7855.2 7882.3 8042.6 8602.8 8618.0 8623.9 8682.0 8697.2 7712.7 7877.7 7972.3 8065.6 8076.8 7312.2 7524.2 7614.2 7700.8 7889.8 6898.1 7053.6 7071.5 7077.4 7087.4 5204.9 5368.3 5454.2 5510.6 5519.0 5542.8 5625.2 5627.8 5673.8 5733.6 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#4] prototype.html Cycles:180 Average:4862.72 Median:5610.44 stddev:1443.94 (25.7%) stddev-sans-first:1406.96 10:26:21 INFO - PROCESS | 4894 | Values: 309.3 311.8 316.8 322.4 323.5 5586.3 5587.4 5601.3 5609.3 5629.7 5505.9 5540.5 5544.3 5566.8 5611.6 4072.3 4206.2 4225.3 4252.5 4294.7 4290.2 4292.2 4299.7 4309.0 4318.8 4231.6 4250.1 4256.6 4259.2 4270.5 4080.6 4268.7 4269.8 4276.7 4278.8 3738.6 3745.7 3764.2 3771.4 3773.2 5277.9 5346.8 5380.0 5398.9 5412.7 4582.9 4867.3 4882.7 4948.7 4975.2 5750.3 5753.0 5758.5 5777.6 5785.5 4062.6 4071.5 4087.2 4093.0 4094.5 5947.4 6047.4 6049.6 6090.7 6102.7 4138.4 4150.8 4169.2 4248.9 4258.3 4269.8 4273.7 4280.9 4336.0 4337.0 4695.6 4880.7 4881.8 4958.7 4959.6 5843.2 5856.4 5878.9 5915.5 5927.2 1478.9 1483.4 1483.6 1487.6 1495.7 942.4 943.9 951.1 958.9 965.2 5498.0 5615.3 5616.4 5662.9 5715.6 5898.4 5924.1 5949.4 5952.2 6020.2 5331.0 5541.8 5547.9 5567.1 5578.2 3105.3 3169.7 3170.0 3212.2 3226.5 5853.8 6088.7 6130.8 6138.4 6144.7 5985.6 6011.7 6015.8 6020.4 6049.0 6068.7 6101.9 6102.8 6112.3 6113.8 5834.3 5899.1 5936.5 5963.2 5964.2 5801.8 5857.7 5861.9 5869.7 5879.6 5794.0 6052.3 6105.4 6107.1 6143.8 4068.0 4077.6 4081.0 4106.7 4141.1 5654.9 5932.0 5951.5 5957.3 5963.3 5759.0 5805.4 5864.5 5867.4 5889.0 5772.9 5781.8 5782.6 5790.4 5909.0 5525.8 5684.5 5689.4 5706.3 5726.3 5796.7 5827.0 5833.9 5839.6 5841.6 5396.0 5645.9 5678.8 5687.3 5784.6 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [#5] yui.html Cycles:180 Average:16250.83 Median:25405.71 stddev:20232.43 (79.6%) stddev-sans-first:20255.95 10:26:21 INFO - PROCESS | 4894 | Values: 805.5 814.3 825.4 827.6 842.2 13499.1 13882.6 14338.6 14371.9 14373.0 13676.5 13722.1 13795.8 13809.2 13839.9 670.1 780.9 790.3 800.6 804.4 795.2 796.1 796.8 797.6 798.7 844.5 847.0 847.6 848.2 852.9 840.4 844.3 846.6 847.2 848.2 609.2 611.4 614.3 614.3 616.0 13641.0 13675.5 13695.6 13699.7 13719.0 13873.1 13951.2 13956.0 13973.4 14089.2 10531.3 10545.6 10607.7 10686.0 10826.8 3745.4 3765.4 3797.9 3827.8 3945.5 63558.7 63805.4 64345.7 64863.7 65354.3 10843.3 10916.8 10933.7 10966.7 11041.2 20179.9 20236.8 20252.2 20255.6 20373.1 8126.2 8183.8 8206.2 8252.9 8543.4 4800.5 4835.8 4883.6 4896.4 4984.7 3437.5 3536.7 3546.6 3549.7 3549.9 606.1 612.1 616.1 631.6 636.8 681.6 766.0 777.6 788.0 818.7 8814.9 8946.4 8961.6 9109.7 9377.4 776.4 785.7 792.5 796.3 803.0 4393.8 4441.5 4484.0 4487.3 4578.4 72468.0 72993.6 73498.6 73671.3 74763.0 64831.0 65350.7 65447.3 65839.0 67922.3 59116.0 59373.1 59716.4 60020.4 61286.7 8584.0 8624.4 8649.7 8708.4 8894.7 38727.0 38771.4 39716.0 39905.0 40335.6 43581.8 46233.0 47697.0 48569.8 54192.7 10950.8 11588.9 11750.3 12099.5 12253.4 13621.9 13758.7 13965.2 14163.9 14261.5 12412.7 13000.6 13476.0 13644.3 13853.9 12807.7 12845.6 13061.6 13573.0 13593.1 12652.4 12898.7 12926.5 13072.1 13085.3 10254.4 10429.6 10832.4 11003.4 11080.2 10820.3 11136.0 11146.7 11272.8 11282.9 10:26:21 INFO - PROCESS | 4894 | -------- Summary: end -------- 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | [Child 4956] WARNING: pipe error: Broken pipe: file /builds/slave/m-cen-l64-pgo-0000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 660 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | ###!!! [Child][MessageChannel] Error: (msgtype=0x46010F,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | 10:26:21 INFO - PROCESS | 4894 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 10:26:21 INFO - PROCESS | 4894 | 10:26:22 INFO - TEST-INFO | 4894: exit 0 10:26:22 INFO - TEST-OK | dromaeo_css | took 1110348ms 10:26:22 INFO - TEST-START | kraken 10:26:22 INFO - operating with platform_type : linux_ 10:26:22 INFO - Initialising browser for kraken test... 10:26:22 INFO - TEST-INFO | started process 5130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNLYMzb/profile http://localhost:45835/getInfo.html) 10:26:26 INFO - PROCESS | 5130 | 10:26:26 INFO - PROCESS | 5130 | (process:5196): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:26 INFO - PROCESS | 5130 | __metrics Screen width/height:1600/1200 10:26:26 INFO - PROCESS | 5130 | colorDepth:24 10:26:26 INFO - PROCESS | 5130 | Browser inner width/height: 1024/697 10:26:26 INFO - PROCESS | 5130 | __metrics 10:26:27 ERROR - PROCESS | 5130 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:26:28 INFO - TEST-INFO | 5130: exit 0 10:26:28 INFO - Browser initialized. 10:26:28 INFO - Running cycle 1/1 for kraken test... 10:26:28 INFO - TEST-INFO | started process 5247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNLYMzb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:30 INFO - PROCESS | 5247 | 10:26:30 INFO - PROCESS | 5247 | (process:5310): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:26:40 INFO - PROCESS | 5247 | RSS: Main: 164184064 10:26:40 INFO - PROCESS | 5247 | 10:26:42 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45835/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:43 INFO - PROCESS | 5247 | RSS: Main: 168964096 10:26:43 INFO - PROCESS | 5247 | 10:26:46 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45835/tests/kraken/driver.html?testName=audio-dft) 10:26:46 INFO - PROCESS | 5247 | RSS: Main: 169848832 10:26:46 INFO - PROCESS | 5247 | 10:26:49 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45835/tests/kraken/driver.html?testName=audio-fft) 10:26:50 INFO - PROCESS | 5247 | RSS: Main: 164405248 10:26:50 INFO - PROCESS | 5247 | 10:26:52 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45835/tests/kraken/driver.html?testName=audio-oscillator) 10:26:53 INFO - PROCESS | 5247 | RSS: Main: 165081088 10:26:53 INFO - PROCESS | 5247 | 10:26:55 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:55 INFO - PROCESS | 5247 | RSS: Main: 164745216 10:26:55 INFO - PROCESS | 5247 | 10:26:59 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45835/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:59 INFO - PROCESS | 5247 | RSS: Main: 164388864 10:26:59 INFO - PROCESS | 5247 | 10:27:03 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45835/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:03 INFO - PROCESS | 5247 | RSS: Main: 163168256 10:27:03 INFO - PROCESS | 5247 | 10:27:06 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45835/tests/kraken/driver.html?testName=json-parse-financial) 10:27:07 INFO - PROCESS | 5247 | RSS: Main: 164032512 10:27:07 INFO - PROCESS | 5247 | 10:27:08 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:09 INFO - PROCESS | 5247 | RSS: Main: 164442112 10:27:09 INFO - PROCESS | 5247 | 10:27:11 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:11 INFO - PROCESS | 5247 | RSS: Main: 164552704 10:27:11 INFO - PROCESS | 5247 | 10:27:13 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:14 INFO - PROCESS | 5247 | RSS: Main: 164700160 10:27:14 INFO - PROCESS | 5247 | 10:27:17 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:17 INFO - PROCESS | 5247 | RSS: Main: 164724736 10:27:17 INFO - PROCESS | 5247 | 10:27:20 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:21 INFO - PROCESS | 5247 | RSS: Main: 165085184 10:27:21 INFO - PROCESS | 5247 | 10:27:22 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:45835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45835/tests/kraken/driver.html?testName=ai-astar) 10:27:23 INFO - PROCESS | 5247 | RSS: Main: 166502400 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | __start_tp_report 10:27:23 INFO - PROCESS | 5247 | _x_x_mozilla_page_load 10:27:23 INFO - PROCESS | 5247 | _x_x_mozilla_page_load_details 10:27:23 INFO - PROCESS | 5247 | |i|pagename|runs| 10:27:23 INFO - PROCESS | 5247 | |0;ai-astar;112;105;111;110;111;113;110;111;111;111 10:27:23 INFO - PROCESS | 5247 | |1;audio-beat-detection;150;125;153;189;128;155;150;130;176;132 10:27:23 INFO - PROCESS | 5247 | |2;audio-dft;161;162;163;165;161;170;166;161;160;164 10:27:23 INFO - PROCESS | 5247 | |3;audio-fft;74;75;74;167;77;74;75;75;167;74 10:27:23 INFO - PROCESS | 5247 | |4;audio-oscillator;83;84;155;83;84;83;149;84;84;147 10:27:23 INFO - PROCESS | 5247 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;118;118;118 10:27:23 INFO - PROCESS | 5247 | |6;imaging-darkroom;147;148;148;146;149;147;147;149;146;145 10:27:23 INFO - PROCESS | 5247 | |7;imaging-desaturate;96;98;96;96;96;96;97;96;96;96 10:27:23 INFO - PROCESS | 5247 | |8;json-parse-financial;56;57;58;56;56;57;56;74;64;54 10:27:23 INFO - PROCESS | 5247 | |9;json-stringify-tinderbox;61;62;63;62;63;62;63;62;62;63 10:27:23 INFO - PROCESS | 5247 | |10;stanford-crypto-aes;79;80;87;82;87;81;82;81;82;83 10:27:23 INFO - PROCESS | 5247 | |11;stanford-crypto-ccm;133;120;122;119;123;120;132;135;163;132 10:27:23 INFO - PROCESS | 5247 | |12;stanford-crypto-pbkdf2;164;168;169;161;165;163;162;167;163;168 10:27:23 INFO - PROCESS | 5247 | |13;stanford-crypto-sha256-iterative;65;66;64;65;64;63;65;62;64;66 10:27:23 INFO - PROCESS | 5247 | __end_tp_report 10:27:23 INFO - PROCESS | 5247 | __start_cc_report 10:27:23 INFO - PROCESS | 5247 | _x_x_mozilla_cycle_collect,875 10:27:23 INFO - PROCESS | 5247 | __end_cc_report 10:27:23 INFO - PROCESS | 5247 | __startTimestamp1464110843098__endTimestamp 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | ------- Summary: start ------- 10:27:23 INFO - PROCESS | 5247 | Number of tests: 14 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.18 10:27:23 INFO - PROCESS | 5247 | Values: 112.0 105.0 111.0 110.0 111.0 113.0 110.0 111.0 111.0 111.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:151.50 stddev:21.21 (14.0%) stddev-sans-first:22.49 10:27:23 INFO - PROCESS | 5247 | Values: 150.0 125.0 153.0 189.0 128.0 155.0 150.0 130.0 176.0 132.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:3.06 (1.9%) stddev-sans-first:3.13 10:27:23 INFO - PROCESS | 5247 | Values: 161.0 162.0 163.0 165.0 161.0 170.0 166.0 161.0 160.0 164.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:38.91 (52.2%) stddev-sans-first:40.64 10:27:23 INFO - PROCESS | 5247 | Values: 74.0 75.0 74.0 167.0 77.0 74.0 75.0 75.0 167.0 74.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:83.50 stddev:32.31 (38.7%) stddev-sans-first:33.40 10:27:23 INFO - PROCESS | 5247 | Values: 83.0 84.0 155.0 83.0 84.0 83.0 149.0 84.0 84.0 147.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:27:23 INFO - PROCESS | 5247 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.32 (0.9%) stddev-sans-first:1.39 10:27:23 INFO - PROCESS | 5247 | Values: 147.0 148.0 148.0 146.0 149.0 147.0 147.0 149.0 146.0 145.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:27:23 INFO - PROCESS | 5247 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.00 stddev:5.96 (10.5%) stddev-sans-first:6.23 10:27:23 INFO - PROCESS | 5247 | Values: 56.0 57.0 58.0 56.0 56.0 57.0 56.0 74.0 64.0 54.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 10:27:23 INFO - PROCESS | 5247 | Values: 61.0 62.0 63.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.67 (3.3%) stddev-sans-first:2.54 10:27:23 INFO - PROCESS | 5247 | Values: 79.0 80.0 87.0 82.0 87.0 81.0 82.0 81.0 82.0 83.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:132.00 stddev:13.19 (10.0%) stddev-sans-first:13.94 10:27:23 INFO - PROCESS | 5247 | Values: 133.0 120.0 122.0 119.0 123.0 120.0 132.0 135.0 163.0 132.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.00 stddev:2.83 (1.7%) stddev-sans-first:2.98 10:27:23 INFO - PROCESS | 5247 | Values: 164.0 168.0 169.0 161.0 165.0 163.0 162.0 167.0 163.0 168.0 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - PROCESS | 5247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 10:27:23 INFO - PROCESS | 5247 | Values: 65.0 66.0 64.0 65.0 64.0 63.0 65.0 62.0 64.0 66.0 10:27:23 INFO - PROCESS | 5247 | -------- Summary: end -------- 10:27:23 INFO - PROCESS | 5247 | 10:27:23 INFO - TEST-INFO | 5247: exit 0 10:27:24 INFO - TEST-OK | kraken | took 61606ms 10:27:24 INFO - SUITE-END | took 1171s 10:27:24 INFO - Completed test suite (00:19:32) 10:27:24 INFO - javascript benchmark 10:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7177.470295780874, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.3621707549955, 3147.543606177103, 3165.986884197057, 3181.5704879841214, 3193.8722451101958, 5462.78148874045, 5507.834764957052, 5523.4476552344795, 5568.470995255454, 5602.60781745278, 5309.442508536606, 5346.893062138755, 5359.866003349908, 5480.342358916935, 5564.916526252099, 4988.476209997962, 5016.548510634042, 5052.974735126338, 5088.771005304751, 5146.228065790124, 600.3514185191241, 5043.974780126113, 5162.328897243353, 5182.067227898977, 5191.610629202806, 5024.648274620797, 5028.069807085701, 5037.924431133536, 5069.2649565812935, 5083.262926875619, 5022.824201152978, 5027.044861476308, 5035.924461133086, 5058.291839142523, 5090.898182036375, 4916.213405855046, 4941.258811178352, 4963.503649635044, 4976.726280054596, 4995.650304478688, 5354.812581559666, 5415.48552887479, 5417.891642167174, 5443.59173062018, 5481.862953426156, 5814.389489103625, 5861.6483011019045, 5873.735681894325, 5882.47057764799, 5885.352611212763, 5653.519450846683, 5705.486506214461, 5721.284839395075, 5748.683822389767, 5923.674197919113, 5305.495977882095, 5338.572914166896, 5346.572274218053, 5350.705711185883, 5374.6237763356585, 5879.265091863517, 5883.705814709333, 5890.558208134407, 5912.260967379078, 5927.585069045125, 5626.718664066781, 5637.661740295595, 5659.915101273484, 5677.148427735872, 5725.942740572541, 5801.129830525455, 5816.82549523515, 5832.066869300891, 5839.678817664984, 5839.678817665069, 5691.943080569225, 5740.942590574041, 5784.305883294031, 5809.2738407699035, 5831.88336233273, 5773.39379365169, 5837.270341207349, 5880.882632299849, 5916.852078698067, 5918.526517878559, 4371.540988196193, 4414.492333381702, 4445.799939002753, 4445.844395446144, 4479.932801007987, 3975.0, 3996.440498330236, 4000.299947509174, 4017.216642754635, 4026.315526360526, 5502.614816962774, 5600.635958662674, 5654.491095801398, 5712.885742285131, 5740.110282906073, 5954.07711804671, 5972.820815375546, 5984.072468767348, 5995.400459953969, 6002.579819412686, 5481.75332110056, 5711.657300561979, 5723.341815691166, 5729.455701708331, 5735.738137609719, 4898.632602554822, 4926.285688575136, 4934.087193869145, 4939.506049395103, 4955.529224723646, 6148.1699970504305, 6170.475509581646, 6172.938270617326, 6183.536234782409, 6187.597806142587, 5689.743961521659, 5753.568482363756, 5968.641881487125, 5968.910466343008, 5972.163897054415, 5933.881322373615, 5950.9702451487465, 5971.4327138921735, 5982.880342393215, 6041.969790151021, 5665.716714164358, 5668.404817494269, 5670.206171136127, 5679.829605111853, 5710.828675139753, 5730.08318669011, 5773.134029895549, 5795.188673585786, 5802.245708057925, 5867.853303667443, 5723.313202415737, 5725.055365864586, 5730.541556675373, 5731.627444216113, 5759.308882933907, 5654.3497497788285, 5685.943140568541, 5718.428157184248, 5739.827805165852, 5752.050911599539, 5516.668999860021, 5607.327120745536, 5621.044422448112, 5635.323761148688, 5684.431556844283, 5608.298962629671, 5772.422757724362, 5786.450287222707, 5816.447437493432, 5857.121431785266, 5698.6580805151825, 5758.424157584208, 5759.049756790083, 5766.769329226784, 5781.595288329777], "value": 5366.4584814133395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6346011632321, 594.8780499997501, 604.4892066204056, 608.9878202435954, 615.3446579392948, 40986.97532561684, 41849.58150418495, 41974.58025419745, 42059.36910946338, 45222.32166517505, 39779.0, 39914.0, 40024.599754002455, 40200.59799402005, 40437.797811010976, 8637.0499245083, 8849.601767920427, 8853.5573221339, 8856.247218986362, 8885.95557022214, 8635.179657932518, 8739.781505462382, 8742.737717868475, 8747.912520874774, 8748.475091494498, 8807.603657835381, 8829.293656507463, 8835.77910552235, 8852.778680533005, 8869.512176830272, 8674.86987695185, 8709.56452177395, 8746.34402419821, 8751.0, 8761.737147885542, 8630.309575234029, 8679.609417576161, 8715.782105447352, 8729.60716767747, 8749.343799215085, 41494.37758433626, 41535.0, 41654.583454165375, 41843.790781046206, 41919.0, 3748.775073495599, 3752.605976372496, 3766.9811650941842, 4165.146145040259, 4329.631981281595, 31694.841525792224, 31920.840395798106, 32446.837765811255, 32447.0, 33317.666823331696, 3800.9429858552144, 3857.4213867919757, 3862.478565393664, 3888.552816426119, 3967.6230758077936, 330345.0, 334092.0, 334209.0, 334704.0, 335803.0, 55476.0, 55787.72106139443, 55841.72079139578, 55958.44041559614, 56016.71991640016, 35821.41785821449, 36501.26997460036, 36680.63319366772, 38483.80758096192, 58771.70614146988, 16280.185990700418, 16400.425985090704, 16505.752413713803, 16551.172441377883, 16561.17194140288, 12603.117781755373, 12609.0, 12628.0, 12629.810552841715, 12639.368031598384, 18670.53323666919, 18693.813061869478, 18847.151878165514, 18990.525236869187, 19046.428607141806, 6858.177018757781, 6954.547954382949, 6965.930340696629, 7151.392131668762, 7329.74345897891, 994.7165057958447, 1060.2419270221828, 1076.214363514623, 1104.2938659770514, 1200.6338066889507, 31795.36409271848, 32417.35165296681, 32557.83721081427, 33001.339973200884, 35420.82289588536, 1043.1967385113421, 1141.9429028548539, 1143.731223162556, 1173.7711146326556, 1254.4793910527028, 16646.334146634243, 17153.0, 17295.913520432317, 17351.56621084483, 17351.826481735272, 477209.0, 488699.0, 488828.0, 491377.0, 493736.0, 58665.70667146637, 58881.70559147177, 59157.0, 59292.70353648204, 59692.40307596955, 1356.504875720355, 1415.2994267837487, 1425.2232533269394, 1435.411481292665, 1444.8916331274986, 31750.841245793625, 32424.83787581047, 32659.673403265664, 32850.671493285714, 32949.341013179124, 51993.48006519886, 52312.738436307576, 52624.473755261955, 52698.47301526936, 52723.20915186352, 353642.0, 356197.0, 356207.0, 357059.0, 357415.0, 42951.14097717965, 43543.56456435522, 45693.771531142134, 46819.29771053505, 47835.0, 47320.763396182796, 49888.0, 50068.749656251486, 51009.489905100476, 51034.234486483474, 41917.0, 43142.0, 43184.13631727285, 43454.34818477662, 44288.4499042532, 42330.1533969325, 42634.57365426306, 42637.786811065744, 42768.78615606902, 43167.56832431635, 43212.0, 44732.10535789331, 45335.31997020113, 45675.31487027764, 45898.77050614726, 39655.80172099121, 40597.1880562393, 41344.0, 42089.36865946952, 42579.361309581, 34046.0, 34497.827510862284, 34572.0, 34689.65310346864, 34767.82616086904], "value": 20254.857658663634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.85965473465336, 365.43357795417097, 369.5620689482962, 378.402124643064, 379.00889174807867, 17720.291188352465, 19279.518012049706, 19443.902780486114, 20121.496962575926, 20122.59754804903, 18498.630027399446, 18906.149223284952, 19304.613907721836, 19320.51698707533, 19370.51573710658, 5404.945950540484, 5481.99999999999, 5649.1526271059465, 5675.177099320596, 5682.943170568283, 5529.917051244234, 5588.133839254901, 5605.607607467479, 5621.072523033695, 5646.717664116778, 5109.540141387274, 5569.805056823012, 5572.5263352615075, 5581.358143813472, 5582.720863956806, 5378.031954248234, 5437.238786569844, 5445.618806683534, 5475.616706830523, 5489.4236105208975, 5180.5337519623035, 5617.719114044322, 5635.1828984796975, 5639.943600563983, 5655.3779084300695, 11215.158863085302, 11295.096392288597, 11358.148138889534, 12160.574379896749, 14096.647583810487, 2123.3629911026783, 2227.175944900381, 2267.7958983691547, 2314.7916687498205, 2488.0, 9740.610375584969, 9984.950075249577, 10287.897121028844, 11294.604688835934, 14073.522280160538, 1870.4669169286688, 1899.1264018551483, 1940.4566721318054, 2005.5487515309085, 2028.3103744726864, 72721.0, 74759.25240747632, 74963.25036749672, 83591.16408835955, 88218.55890720569, 10485.737856553647, 10917.39954302521, 11008.009279164913, 11070.833937490945, 11151.776964460827, 15123.092614443169, 15177.848221517865, 15251.313690883937, 15258.923705381623, 15263.08421494714, 8142.837143257102, 8186.7953301167945, 8215.917840821516, 8260.752177434686, 8342.582870856433, 7772.805679858049, 7807.726729564438, 7925.326347260432, 7967.880481792778, 7991.200879912079, 4534.79593418297, 4706.176419126639, 4718.103560323528, 4768.332433459318, 4827.155247831615, 1855.2949879046146, 1907.2943011085988, 1907.399169261678, 1907.7424547685885, 1991.2831380702935, 934.2619330728784, 1028.377831412, 1040.107005250437, 1073.538378497238, 1098.752780624369, 18533.721994170097, 19036.238550457827, 19188.71216931747, 19275.710864337045, 19365.225390984204, 972.3873959405671, 998.1565577087349, 1032.932859364154, 1039.7816458543791, 1082.1396989393452, 10446.529906154241, 10823.296485728402, 10888.40113793749, 10941.945290273497, 10950.835737463944, 416264.9186754047, 418607.0, 462488.0, 470150.0, 473500.0, 78834.0, 86475.56762216275, 87675.0, 92797.0, 99755.0, 1043.8642976413018, 1059.7933402986343, 1076.3541874875011, 1085.0993675249524, 1086.1419478611965, 15795.605109872346, 17151.228194731517, 17319.220635071702, 17401.303947841945, 17520.561985950455, 32002.83998579992, 38183.04542386463, 39802.60197397989, 40864.0, 45095.0, 58745.11882321683, 60050.099248510436, 60822.0, 61226.387736122066, 61312.386876132456, 7803.531788092732, 8190.385721070825, 8193.262606365455, 8284.83430331402, 8425.789355266168, 9116.4074335168, 11176.16178786578, 12485.250884946932, 13187.60437186886, 13200.14199077057, 10750.247482676137, 10804.40575768309, 10824.945875270574, 10922.0, 11003.184713375605, 10181.592736290466, 10545.789084218426, 10651.254412191382, 10763.192760543147, 10977.28647637901, 6760.0, 10476.63331783384, 10707.143428525544, 11054.281471704313, 11342.035926946302, 7889.447738658238, 7889.6449659766595, 7904.960475197818, 8008.199180081945, 8021.358291336563, 9624.278179136452, 10326.173906087344, 10481.528331224961, 10519.631812886511, 10635.415052172204], "value": 8828.137599972479, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.3181184372954, 1554.712378210031, 1703.4804384662673, 1835.9902053870385, 1847.362659882341, 8151.103378628361, 8421.70524031659, 8815.911840881588, 9373.953130234348, 9375.531223438826, 8427.199416055464, 8490.448120872139, 8500.362472814548, 8541.188587084218, 8572.271356934669, 2325.6162733149054, 2364.4443555764383, 2365.95268094638, 2366.183666635017, 2366.692329997098, 2283.8515496492673, 2309.642005489152, 2320.176337400224, 2328.080408238745, 2342.9882850585723, 2250.4711392822674, 2253.3352660965056, 2255.154317131076, 2325.1164557468223, 2326.523062772136, 2332.195392589554, 2352.3060697094397, 2364.0780095762666, 2367.2661474942824, 2370.9051637934463, 2341.1922886604093, 2356.787889089973, 2369.040538581877, 2369.7748713872156, 2376.65538496917, 8558.186972237627, 8637.179467950535, 8644.227933273663, 8645.265152462049, 8648.351373647001, 5180.585553155738, 5278.102722537178, 5342.225377320306, 5430.8913821723345, 5483.561315094783, 3351.128706536318, 3398.8130652814084, 3432.5366075579977, 3434.6565343465704, 3451.741119416054, 1049.3703777733376, 1069.7860427914447, 1070.689500044986, 1082.426314053545, 1092.6831218946495, 12880.162789418659, 12896.935515322457, 12929.0, 12967.935160324232, 12971.221726696429, 4694.694844835075, 4694.788734506956, 4967.379077615298, 4980.8754781130765, 4992.525710057539, 10743.194260430499, 10801.513931872927, 10877.728056798644, 10908.181886358554, 10968.890311096946, 5407.567394608422, 5409.404965453797, 5423.213634023124, 5467.726613669301, 5497.505224529811, 4349.238883195429, 4833.492483289274, 4928.359313289249, 4969.2546118081855, 5014.548690617862, 3954.584768599313, 3962.425448309979, 4037.6971727120585, 4105.8973525662095, 4116.073883376216, 1182.485618755844, 1204.1631066408936, 1277.2719549856492, 1283.640580637423, 1286.7619490394306, 898.3486971945288, 991.8908920018793, 1015.3907655406697, 1026.2662196529518, 1029.1509504658536, 6332.1135041094285, 6378.2346118466085, 6379.744810207632, 6412.487001039905, 6445.291017988017, 461.1284671969979, 464.3615029334665, 472.15719939907103, 476.1072988147224, 480.0183624487931, 4276.144771045803, 4332.393464914914, 4406.581374769392, 4427.380166776589, 4456.242438785414, 11244.437778111062, 11537.250078744855, 11609.419529023515, 11637.418129093512, 11712.88287117135, 10872.945635271773, 11497.770044599061, 11548.076153907667, 11552.133589980785, 11573.826392604118, 8457.281131103926, 8520.829583408296, 8568.357373197035, 8652.8702069469, 8700.956495217484, 6198.659073750807, 6302.464290535356, 6336.7465301389275, 6381.202349706286, 6447.6453795041725, 9430.434173949585, 10575.735606609589, 10595.735106622396, 10615.1507879371, 10668.1998850085, 9883.01169883006, 9979.401235925867, 10063.345882517613, 10136.543855526372, 10164.288499805238, 7057.576545407292, 7602.657880395285, 7855.214478552099, 7882.330001949898, 8042.638081286239, 8602.78493037679, 8617.95691021541, 8623.913760862311, 8682.0, 8697.173768491983, 7712.652930618248, 7877.724279650185, 7972.2824945755165, 8065.596720163851, 8076.757697269091, 7312.19565847767, 7524.17234104259, 7614.200508946481, 7700.768976930701, 7889.84220315579, 6898.103246577913, 7053.647317633995, 7071.5049946505305, 7077.363037326665, 7087.362137407658, 5204.921926171186, 5368.302120724281, 5454.154606036071, 5510.586705997146, 5519.034169020486, 5542.750576223999, 5625.212470254086, 5627.803026894039, 5673.8297851064535, 5733.569982251432], "value": 4658.040906261633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.3241267829792, 311.83161093009767, 316.8304956848087, 322.4212538493404, 323.4517492849621, 5586.301712285965, 5587.441255874415, 5601.327840659126, 5609.298837645294, 5629.718514074295, 5505.862353441166, 5540.473655002778, 5544.306961629796, 5566.805161819337, 5611.579131565129, 4072.3484242521126, 4206.20082184384, 4225.302825033866, 4252.468441444819, 4294.67789915756, 4290.163418133465, 4292.227399068166, 4299.677524185683, 4309.008927946574, 4318.82724691012, 4231.619154276114, 4250.128723611652, 4256.59562341577, 4259.212045771542, 4270.487541495009, 4080.6123418275365, 4268.701190916637, 4269.786510674485, 4276.657867370603, 4278.786060696968, 3738.6261373862667, 3745.7190710696805, 3764.247150569897, 3771.358868992278, 3773.2264885698364, 5277.944411117792, 5346.812861549866, 5379.973100134474, 5398.8920221595345, 5412.675239485643, 4582.885427864297, 4867.342908707315, 4882.731449770261, 4948.7278199699, 4975.203967365204, 5750.252467179282, 5752.971235143839, 5758.48173664368, 5777.5666824987875, 5785.450382213683, 4062.634362907323, 4071.491063617048, 4087.2438598859308, 4092.9795351023054, 4094.467719196515, 5947.4052594740615, 6047.425494578052, 6049.637021778663, 6090.665013424215, 6102.72537735803, 4138.379243113557, 4150.813213405404, 4169.249535083714, 4248.91502169961, 4258.276093064186, 4269.807858646368, 4273.658107351404, 4280.850170244026, 4336.002719374498, 4337.0, 4695.624350052056, 4880.682755620874, 4881.829135980223, 4958.677685950402, 4959.578435832923, 5843.217818565294, 5856.4143585641095, 5878.911816322759, 5915.526757859361, 5927.229460170151, 1478.8595083467053, 1483.3843954758654, 1483.562349107016, 1487.6280929767559, 1495.7307684616655, 942.4345392764286, 943.8725772020827, 951.1012093571646, 958.9328746987784, 965.1699538396973, 5497.9828731684765, 5615.298087739033, 5616.354119276254, 5662.886742265214, 5715.599908006483, 5898.436914217736, 5924.052151655715, 5949.393663710774, 5952.196453478811, 6020.187274717945, 5331.0, 5541.806036788693, 5547.861303467364, 5567.137093750475, 5578.191162281528, 3105.261053809874, 3169.6513383527795, 3169.968300316967, 3212.229065024424, 3226.467632840602, 5853.765849365977, 6088.695565221721, 6130.785422510191, 6138.355472675394, 6144.662043587646, 5985.581009329305, 6011.699415029231, 6015.819525414245, 6020.397960203944, 6049.0, 6068.696565171724, 6101.871153836554, 6102.847428814315, 6112.297085835097, 6113.8471538211015, 5834.329052158886, 5899.144624029406, 5936.525077993837, 5963.194968679173, 5964.165016897551, 5801.796937107181, 5857.736401861841, 5861.912071318849, 5869.6771677558145, 5879.559033072451, 5793.9860524408905, 6052.273727152769, 6105.389461053859, 6107.114468402146, 6143.754249829957, 4068.0033391819193, 4077.612626800449, 4081.0, 4106.733062350938, 4141.130362623882, 5654.85862853432, 5931.970340148272, 5951.464368206882, 5957.255343082114, 5963.254593175853, 5758.971205143947, 5805.361410244954, 5864.501517371071, 5867.383924688017, 5888.998870192163, 5772.913406298825, 5781.831813070099, 5782.595218334676, 5790.449907258803, 5908.970455147697, 5525.751341189576, 5684.459976302244, 5689.431056894277, 5706.3152421709665, 5726.284214473191, 5796.652200867961, 5826.970865145647, 5833.854153646023, 5839.562032847638, 5841.561882858718, 5396.028714831211, 5645.943540564542, 5678.829635110953, 5687.260656114679, 5784.595078344475], "value": 4391.963886600495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.5408417202195, 814.3241109878801, 825.372716735281, 827.6110228192755, 842.2461896602541, 13499.122557033787, 13882.58352249433, 14338.641533961656, 14371.92814035931, 14373.0, 13676.452941882313, 13722.1080629759, 13795.793063104036, 13809.24049177295, 13839.93080034601, 670.088679396021, 780.8555417247799, 790.2532107158723, 800.5796956597775, 804.4288555125838, 795.2484901767832, 796.1481215099845, 796.8485987662326, 797.6330887791594, 798.6885114805231, 844.5059640110512, 846.9618867150962, 847.5931552854634, 848.2238751542332, 852.8891244138254, 840.3529282452508, 844.3456321350972, 846.6317152038882, 847.2459511035183, 848.240824462106, 609.1958614628692, 611.3855575146994, 614.2720875762236, 614.342653360904, 615.9568830181889, 13641.0, 13675.452981880713, 13695.589132326046, 13699.657508562266, 13719.0, 13873.09824861391, 13951.232682202475, 13956.0, 13973.371198296, 14089.15465072099, 10531.26281160319, 10545.630902918438, 10607.734806629896, 10686.0, 10826.783464330669, 3745.4381842723537, 3765.443426593177, 3797.8697052266534, 3827.8468861245797, 3945.5462621798574, 63558.68220658913, 63805.361946380406, 64345.67827160928, 64863.70272594569, 65354.3464565353, 10843.349399036084, 10916.836247456295, 10933.671989840317, 10966.725831854268, 11041.171912106623, 20179.899100504696, 20236.797632023787, 20252.18991240363, 20255.59488810245, 20373.08321125553, 8126.228008339198, 8183.754487365389, 8206.22040906113, 8252.876206856901, 8543.401961862734, 4800.543948324904, 4835.830745923946, 4883.560479556786, 4896.4124305083615, 4984.651074424828, 3437.4671925851535, 3536.717062634983, 3546.6453354664327, 3549.680528752425, 3549.94675079874, 606.0727087556046, 612.10326871134, 616.1220261127964, 631.6368088349218, 636.7612145445459, 681.6455443169524, 765.950213236149, 777.5645638442377, 787.9527228366317, 818.7216346442119, 8814.86777698335, 8946.418482798597, 8961.641534338683, 9109.726708198765, 9377.390469619453, 776.3827756933251, 785.658238666182, 792.5244853088217, 796.2634563029175, 802.9598520073973, 4393.7758144233885, 4441.489228738672, 4484.0, 4487.349334346502, 4578.427696537933, 72468.0, 72993.6350318245, 73498.63250683712, 73671.26328736644, 74763.0, 64831.0, 65350.67324663441, 65447.345526545076, 65839.01241481381, 67922.30194245183, 59116.0, 59373.10940335898, 59716.40283597195, 60020.399796002355, 61286.69356653188, 8584.029688974912, 8624.396292259482, 8649.740507784776, 8708.390412671306, 8894.688685895962, 38727.03182420462, 38771.41842872303, 39716.02839716121, 39905.0, 40335.596644034355, 43581.78209109061, 46233.0, 47697.0, 48569.75715121402, 54192.72903635457, 10950.780984380428, 11588.884111159117, 11750.29498230109, 12099.455524501594, 12253.387330633255, 13621.863781362059, 13758.724825503634, 13965.221553065277, 14163.929180354033, 14261.500847470288, 12412.689682757642, 13000.628647516707, 13476.0, 13644.317784110954, 13853.861461385257, 12807.743845122859, 12845.550405735754, 13061.608151755463, 13573.04988650785, 13593.11644743128, 12652.430640621378, 12898.742025159632, 12926.547570834975, 13072.084954053125, 13085.280309583064, 10254.436006019741, 10429.634962776267, 10832.350058996486, 11003.449827508754, 11080.224384293022, 10820.296680716043, 11136.0, 11146.721331966766, 11272.774544509228, 11282.94358528235], "value": 6963.65605075862, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 113.0, 110.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 153.0, 189.0, 128.0, 155.0, 150.0, 130.0, 176.0, 132.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 165.0, 161.0, 170.0, 166.0, 161.0, 160.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 167.0, 77.0, 74.0, 75.0, 75.0, 167.0, 74.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 155.0, 83.0, 84.0, 83.0, 149.0, 84.0, 84.0, 147.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 149.0, 147.0, 147.0, 149.0, 146.0, 145.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 56.0, 74.0, 64.0, 54.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 87.0, 82.0, 87.0, 81.0, 82.0, 81.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 120.0, 122.0, 119.0, 123.0, 120.0, 132.0, 135.0, 163.0, 132.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 169.0, 161.0, 165.0, 163.0, 162.0, 167.0, 163.0, 168.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 64.0, 63.0, 65.0, 62.0, 64.0, 66.0], "value": 64.4, "unit": "score"}]}]} 10:27:24 INFO - Return code: 0 10:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:27:24 ERROR - # TBPL SUCCESS # 10:27:24 INFO - Running post-action listener: _resource_record_post_action 10:27:24 INFO - ##### 10:27:24 INFO - ##### Finished run-tests step (success) 10:27:24 INFO - ##### 10:27:24 INFO - Running post-run listener: _resource_record_post_run 10:27:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 237568; Write bytes: 293761024; Read time: 128; Write time: 250068 10:27:24 INFO - TinderboxPrint: CPU usage
13.3% 10:27:24 INFO - TinderboxPrint: I/O read bytes / time
237,568 / 128 10:27:24 INFO - TinderboxPrint: I/O write bytes / time
293,761,024 / 250,068 10:27:24 INFO - TinderboxPrint: CPU idle
8,227.7 (86.6%) 10:27:24 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 10:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 10:27:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5296128; Read time: 0; Write time: 496 10:27:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 237568; Write bytes: 288464896; Read time: 128; Write time: 249572 10:27:25 INFO - Running post-run listener: _upload_blobber_files 10:27:25 INFO - Blob upload gear active. 10:27:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:25 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 10:27:25 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:25 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:26 INFO - (blobuploader) - INFO - Done attempting. 10:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:29 INFO - (blobuploader) - INFO - Done attempting. 10:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:30 INFO - (blobuploader) - INFO - Done attempting. 10:27:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:30 INFO - Return code: 0 10:27:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b533e134835aa0f00d224862706dc966a8f5a970ad7c99c4f8035e16a1f066475f15cf2a46fa58b2801b8d0e605f65452ba404c3a5bc00e599a8171bbe1a9487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aee26863a581c838b2c7eea14dbf615deaf062d2a5658bfc6edb74f85ff949b9b7990f0de5a90a3d1f9c17a8dc66fdc75c967c2bbd35f56e1bbf5b1e8b29326", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f97b1cefbc555085940186fe882bb38505866cebbc5f031561d3cb182ef3fd2ef94576c56f4a72b8734eb0ff1e2e75ab1ab232117ab60c4c0a5b5f0505f5f2c"} 10:27:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:30 INFO - Contents: 10:27:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b533e134835aa0f00d224862706dc966a8f5a970ad7c99c4f8035e16a1f066475f15cf2a46fa58b2801b8d0e605f65452ba404c3a5bc00e599a8171bbe1a9487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aee26863a581c838b2c7eea14dbf615deaf062d2a5658bfc6edb74f85ff949b9b7990f0de5a90a3d1f9c17a8dc66fdc75c967c2bbd35f56e1bbf5b1e8b29326", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f97b1cefbc555085940186fe882bb38505866cebbc5f031561d3cb182ef3fd2ef94576c56f4a72b8734eb0ff1e2e75ab1ab232117ab60c4c0a5b5f0505f5f2c"} 10:27:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:30 INFO - Copying logs to upload dir... 10:27:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.521723 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-24 10:27:30.809047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:27:30.812071) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 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/Firefox/sha512/b533e134835aa0f00d224862706dc966a8f5a970ad7c99c4f8035e16a1f066475f15cf2a46fa58b2801b8d0e605f65452ba404c3a5bc00e599a8171bbe1a9487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aee26863a581c838b2c7eea14dbf615deaf062d2a5658bfc6edb74f85ff949b9b7990f0de5a90a3d1f9c17a8dc66fdc75c967c2bbd35f56e1bbf5b1e8b29326", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f97b1cefbc555085940186fe882bb38505866cebbc5f031561d3cb182ef3fd2ef94576c56f4a72b8734eb0ff1e2e75ab1ab232117ab60c4c0a5b5f0505f5f2c"} build_url:https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/DoNns8flQRSK0zqagCScPg/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/Firefox/sha512/b533e134835aa0f00d224862706dc966a8f5a970ad7c99c4f8035e16a1f066475f15cf2a46fa58b2801b8d0e605f65452ba404c3a5bc00e599a8171bbe1a9487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aee26863a581c838b2c7eea14dbf615deaf062d2a5658bfc6edb74f85ff949b9b7990f0de5a90a3d1f9c17a8dc66fdc75c967c2bbd35f56e1bbf5b1e8b29326", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f97b1cefbc555085940186fe882bb38505866cebbc5f031561d3cb182ef3fd2ef94576c56f4a72b8734eb0ff1e2e75ab1ab232117ab60c4c0a5b5f0505f5f2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:27:30.836851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:27:30.837172) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464109616.792317-1965458298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004786 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:27:30.921599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:27:30.921920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:27:30.922209) ========= ========= Total master_lag: 0.16 =========