builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1463650001.73 results: success (0) buildid: 20160517065136 builduid: ab760662d3a1428fa4c9e673ad9c7baf revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.727929) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.728392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.728708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.744649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.745018) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 02:26:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-05-19 02:26:42 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.837342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.837669) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.887206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:41.887566) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3780a3a6b83aeda143f9562829c830410a0c961e --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 3780a3a6b83aeda143f9562829c830410a0c961e --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=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 02:26:42,820 truncating revision to first 12 chars 2016-05-19 02:26:42,820 Setting DEBUG logging. 2016-05-19 02:26:42,820 attempt 1/10 2016-05-19 02:26:42,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3780a3a6b83a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 02:26:43,513 unpacking tar archive at: mozilla-central-3780a3a6b83a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.959360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:42.859996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:42.860336) ========= script_repo_revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:42.860792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:42.861063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:26:42.869362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 02:26:42.869670) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:26:43 INFO - MultiFileLogger online at 20160519 02:26:43 in /builds/slave/test 02:26:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:26:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:43 INFO - {'append_to_log': False, 02:26:43 INFO - 'base_work_dir': '/builds/slave/test', 02:26:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:26:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:43 INFO - 'branch': 'Firefox-Non-PGO', 02:26:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:43 INFO - 'config_files': ('talos/linux_config.py',), 02:26:43 INFO - 'default_actions': ('clobber', 02:26:43 INFO - 'read-buildbot-config', 02:26:43 INFO - 'download-and-extract', 02:26:43 INFO - 'populate-webroot', 02:26:43 INFO - 'create-virtualenv', 02:26:43 INFO - 'install', 02:26:43 INFO - 'run-tests'), 02:26:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:43 INFO - 'download_minidump_stackwalk': True, 02:26:43 INFO - 'download_symbols': 'ondemand', 02:26:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:43 INFO - 'installer_path': 'installer.exe', 02:26:43 INFO - 'log_level': 'info', 02:26:43 INFO - 'log_name': 'talos', 02:26:43 INFO - 'log_to_console': True, 02:26:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:26:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:26:43 INFO - 'opt_config_files': (), 02:26:43 INFO - 'pip_index': False, 02:26:43 INFO - 'sps_profile': False, 02:26:43 INFO - 'sps_profile_interval': 0, 02:26:43 INFO - 'suite': 'dromaeojs-e10s', 02:26:43 INFO - 'system_bits': '32', 02:26:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:43 INFO - 'title': 'talos-linux64-ix-059', 02:26:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:43 INFO - 'use_talos_json': True, 02:26:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:43 INFO - 'work_dir': 'build'} 02:26:43 INFO - ##### 02:26:43 INFO - ##### Running clobber step. 02:26:43 INFO - ##### 02:26:43 INFO - Running pre-action listener: _resource_record_pre_action 02:26:43 INFO - Running main action method: clobber 02:26:43 INFO - rmtree: /builds/slave/test/build 02:26:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:44 INFO - Running post-action listener: _resource_record_post_action 02:26:44 INFO - ##### 02:26:44 INFO - ##### Finished clobber step (success) 02:26:44 INFO - ##### 02:26:44 INFO - ##### 02:26:44 INFO - ##### Running read-buildbot-config step. 02:26:44 INFO - ##### 02:26:44 INFO - Running pre-action listener: _resource_record_pre_action 02:26:44 INFO - Running main action method: read_buildbot_config 02:26:44 INFO - Using buildbot properties: 02:26:44 INFO - { 02:26:44 INFO - "project": "", 02:26:44 INFO - "product": "firefox", 02:26:44 INFO - "script_repo_revision": "production", 02:26:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:26:44 INFO - "repository": "", 02:26:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:26:44 INFO - "buildid": "20160517065136", 02:26:44 INFO - "pgo_build": "False", 02:26:44 INFO - "basedir": "/builds/slave/test", 02:26:44 INFO - "buildnumber": 61, 02:26:44 INFO - "slavename": "talos-linux64-ix-059", 02:26:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:26:44 INFO - "platform": "ubuntu64_hw", 02:26:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:26:44 INFO - "branch": "mozilla-central", 02:26:44 INFO - "repo_path": "mozilla-central", 02:26:44 INFO - "revision": "3780a3a6b83aeda143f9562829c830410a0c961e", 02:26:44 INFO - "stage_platform": "linux64", 02:26:44 INFO - "builduid": "ab760662d3a1428fa4c9e673ad9c7baf", 02:26:44 INFO - "slavebuilddir": "test" 02:26:44 INFO - } 02:26:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:26:44 INFO - Running post-action listener: _resource_record_post_action 02:26:44 INFO - ##### 02:26:44 INFO - ##### Finished read-buildbot-config step (success) 02:26:44 INFO - ##### 02:26:44 INFO - ##### 02:26:44 INFO - ##### Running download-and-extract step. 02:26:44 INFO - ##### 02:26:44 INFO - Running pre-action listener: _resource_record_pre_action 02:26:44 INFO - Running main action method: download_and_extract 02:26:44 INFO - mkdir: /builds/slave/test/build/tests 02:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:44 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:45 INFO - Downloaded 1361 bytes. 02:26:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:26:45 INFO - Using the following test package requirements: 02:26:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:26:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:26:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:26:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'jsshell-linux-x86_64.zip'], 02:26:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:26:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:26:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:26:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:26:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:26:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:26:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:26:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:45 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:46 INFO - Downloaded 22447955 bytes. 02:26:46 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'] 02:26:46 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 02:26:47 INFO - Return code: 0 02:26:47 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 02:26:47 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')]} 02:26:47 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:48 INFO - Downloaded 22447955 bytes. 02:26:48 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'] 02:26:48 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 02:26:49 INFO - Return code: 0 02:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:49 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:50 INFO - Downloaded 10840194 bytes. 02:26:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:26:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:26:51 INFO - Return code: 0 02:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:51 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/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 02:26:52 INFO - Downloaded 54754715 bytes. 02:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:26:52 INFO - mkdir: /builds/slave/test/properties 02:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:52 INFO - Contents: 02:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:26:53 INFO - Running post-action listener: _resource_record_post_action 02:26:53 INFO - Running post-action listener: set_extra_try_arguments 02:26:53 INFO - ##### 02:26:53 INFO - ##### Finished download-and-extract step (success) 02:26:53 INFO - ##### 02:26:53 INFO - ##### 02:26:53 INFO - ##### Running populate-webroot step. 02:26:53 INFO - ##### 02:26:53 INFO - Running pre-action listener: _resource_record_pre_action 02:26:53 INFO - Running main action method: populate_webroot 02:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:53 INFO - '--tppagecycles', 02:26:53 INFO - '7'], 02:26:53 INFO - 'tests': ['tsvgm']}}, 02:26:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['damp', 'tps']}, 02:26:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['damp', 'tps']}, 02:26:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['dromaeo_dom']}, 02:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tsvgx', 02:26:53 INFO - 'tsvgr_opacity', 02:26:53 INFO - 'tart', 02:26:53 INFO - 'tscrollx', 02:26:53 INFO - 'cart']}, 02:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:53 INFO - 'tsvgr_opacity', 02:26:53 INFO - 'tart', 02:26:53 INFO - 'tscrollx', 02:26:53 INFO - 'cart']}, 02:26:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tp5o']}, 02:26:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['tp5o']}, 02:26:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s', 02:26:53 INFO - '--xperf_path', 02:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:53 INFO - 'tests': ['tp5n']}, 02:26:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--xperf_path', 02:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:53 INFO - 'tests': ['tp5n']}}, 02:26:53 INFO - 'talos.zip': {'path': '', 02:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:53 INFO - Running post-action listener: _resource_record_post_action 02:26:53 INFO - ##### 02:26:53 INFO - ##### Finished populate-webroot step (success) 02:26:53 INFO - ##### 02:26:53 INFO - ##### 02:26:53 INFO - ##### Running create-virtualenv step. 02:26:53 INFO - ##### 02:26:53 INFO - Running pre-action listener: _resource_record_pre_action 02:26:53 INFO - Running main action method: create_virtualenv 02:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:53 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 02:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:53 INFO - Using real prefix '/usr' 02:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:55 INFO - Installing pip.................done. 02:26:55 INFO - Return code: 0 02:26:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:26:55 INFO - Using env: {'DISPLAY': ':0', 02:26:55 INFO - 'HOME': '/home/cltbld', 02:26:55 INFO - 'LANG': 'en_US.UTF-8', 02:26:55 INFO - 'LANGUAGE': 'en_US:en', 02:26:55 INFO - 'LOGNAME': 'cltbld', 02:26:55 INFO - 'MAIL': '/var/mail/cltbld', 02:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:55 INFO - 'MOZ_NO_REMOTE': '1', 02:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:55 INFO - 'NO_EM_RESTART': '1', 02:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:55 INFO - 'PWD': '/builds/slave/test', 02:26:55 INFO - 'SHELL': '/bin/bash', 02:26:55 INFO - 'SHLVL': '1', 02:26:55 INFO - 'TERM': 'linux', 02:26:55 INFO - 'TMOUT': '86400', 02:26:55 INFO - 'USER': 'cltbld', 02:26:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:55 INFO - '_': '/tools/buildbot/bin/python'} 02:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:56 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 02:26:56 INFO - Cleaning up... 02:26:56 INFO - Return code: 0 02:26:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:56 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')]} 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 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')]} 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 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 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:26:56 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 02:26:56 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 02:26:56 INFO - Using env: {'DISPLAY': ':0', 02:26:56 INFO - 'HOME': '/home/cltbld', 02:26:56 INFO - 'LANG': 'en_US.UTF-8', 02:26:56 INFO - 'LANGUAGE': 'en_US:en', 02:26:56 INFO - 'LOGNAME': 'cltbld', 02:26:56 INFO - 'MAIL': '/var/mail/cltbld', 02:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:56 INFO - 'MOZ_NO_REMOTE': '1', 02:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:56 INFO - 'NO_EM_RESTART': '1', 02:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:56 INFO - 'PWD': '/builds/slave/test', 02:26:56 INFO - 'SHELL': '/bin/bash', 02:26:56 INFO - 'SHLVL': '1', 02:26:56 INFO - 'TERM': 'linux', 02:26:56 INFO - 'TMOUT': '86400', 02:26:56 INFO - 'USER': 'cltbld', 02:26:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:56 INFO - '_': '/tools/buildbot/bin/python'} 02:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:56 INFO - Downloading/unpacking psutil>=3.1.1 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:58 INFO - Installing collected packages: psutil 02:26:58 INFO - Running setup.py install for psutil 02:26:58 INFO - building 'psutil._psutil_linux' extension 02:26:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:26:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:26:58 INFO - building 'psutil._psutil_posix' extension 02:26:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:26:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:58 INFO - Successfully installed psutil 02:26:58 INFO - Cleaning up... 02:26:58 INFO - Return code: 0 02:26:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:26:58 INFO - Using env: {'DISPLAY': ':0', 02:26:58 INFO - 'HOME': '/home/cltbld', 02:26:58 INFO - 'LANG': 'en_US.UTF-8', 02:26:58 INFO - 'LANGUAGE': 'en_US:en', 02:26:58 INFO - 'LOGNAME': 'cltbld', 02:26:58 INFO - 'MAIL': '/var/mail/cltbld', 02:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:58 INFO - 'MOZ_NO_REMOTE': '1', 02:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:58 INFO - 'NO_EM_RESTART': '1', 02:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:58 INFO - 'PWD': '/builds/slave/test', 02:26:58 INFO - 'SHELL': '/bin/bash', 02:26:58 INFO - 'SHLVL': '1', 02:26:58 INFO - 'TERM': 'linux', 02:26:58 INFO - 'TMOUT': '86400', 02:26:58 INFO - 'USER': 'cltbld', 02:26:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:58 INFO - '_': '/tools/buildbot/bin/python'} 02:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:00 INFO - Installing collected packages: mozsystemmonitor 02:27:00 INFO - Running setup.py install for mozsystemmonitor 02:27:01 INFO - Successfully installed mozsystemmonitor 02:27:01 INFO - Cleaning up... 02:27:01 INFO - Return code: 0 02:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:01 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 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:01 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 02:27:01 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 02:27:01 INFO - Using env: {'DISPLAY': ':0', 02:27:01 INFO - 'HOME': '/home/cltbld', 02:27:01 INFO - 'LANG': 'en_US.UTF-8', 02:27:01 INFO - 'LANGUAGE': 'en_US:en', 02:27:01 INFO - 'LOGNAME': 'cltbld', 02:27:01 INFO - 'MAIL': '/var/mail/cltbld', 02:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:01 INFO - 'MOZ_NO_REMOTE': '1', 02:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:01 INFO - 'NO_EM_RESTART': '1', 02:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:01 INFO - 'PWD': '/builds/slave/test', 02:27:01 INFO - 'SHELL': '/bin/bash', 02:27:01 INFO - 'SHLVL': '1', 02:27:01 INFO - 'TERM': 'linux', 02:27:01 INFO - 'TMOUT': '86400', 02:27:01 INFO - 'USER': 'cltbld', 02:27:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:01 INFO - '_': '/tools/buildbot/bin/python'} 02:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - Downloading docopt-0.6.1.tar.gz 02:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:04 INFO - Running setup.py install for blobuploader 02:27:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:04 INFO - Running setup.py install for requests 02:27:04 INFO - Running setup.py install for docopt 02:27:04 INFO - Successfully installed blobuploader requests docopt 02:27:04 INFO - Cleaning up... 02:27:04 INFO - Return code: 0 02:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:27:04 INFO - Using env: {'DISPLAY': ':0', 02:27:04 INFO - 'HOME': '/home/cltbld', 02:27:04 INFO - 'LANG': 'en_US.UTF-8', 02:27:04 INFO - 'LANGUAGE': 'en_US:en', 02:27:04 INFO - 'LOGNAME': 'cltbld', 02:27:04 INFO - 'MAIL': '/var/mail/cltbld', 02:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:04 INFO - 'MOZ_NO_REMOTE': '1', 02:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:04 INFO - 'NO_EM_RESTART': '1', 02:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:04 INFO - 'PWD': '/builds/slave/test', 02:27:04 INFO - 'SHELL': '/bin/bash', 02:27:04 INFO - 'SHLVL': '1', 02:27:04 INFO - 'TERM': 'linux', 02:27:04 INFO - 'TMOUT': '86400', 02:27:04 INFO - 'USER': 'cltbld', 02:27:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:04 INFO - '_': '/tools/buildbot/bin/python'} 02:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:05 INFO - Running setup.py (path:/tmp/pip-87Xxr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:05 INFO - Running setup.py (path:/tmp/pip-0YXgBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:05 INFO - Running setup.py (path:/tmp/pip-lB3KC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:05 INFO - Running setup.py (path:/tmp/pip-i2yMCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:05 INFO - Running setup.py (path:/tmp/pip-frFDEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:05 INFO - Running setup.py (path:/tmp/pip-ltzPmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:05 INFO - Running setup.py (path:/tmp/pip-IhdZYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:05 INFO - Running setup.py (path:/tmp/pip-_Z6nFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:05 INFO - Running setup.py (path:/tmp/pip-OF8hVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:05 INFO - Running setup.py (path:/tmp/pip-Irndnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:05 INFO - Running setup.py (path:/tmp/pip-URoMM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:05 INFO - Running setup.py (path:/tmp/pip-wAFFwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:05 INFO - Running setup.py (path:/tmp/pip-LHLAtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:05 INFO - Running setup.py (path:/tmp/pip-SKNqCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:06 INFO - Running setup.py (path:/tmp/pip-jLOYEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:06 INFO - Running setup.py (path:/tmp/pip-ESLCD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:06 INFO - Running setup.py (path:/tmp/pip-Ox3BBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:06 INFO - Running setup.py install for manifestparser 02:27:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Running setup.py install for mozcrash 02:27:06 INFO - Running setup.py install for mozdebug 02:27:06 INFO - Running setup.py install for mozdevice 02:27:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Running setup.py install for mozfile 02:27:06 INFO - Running setup.py install for mozhttpd 02:27:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Running setup.py install for mozinfo 02:27:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Running setup.py install for mozInstall 02:27:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Running setup.py install for mozleak 02:27:07 INFO - Running setup.py install for mozlog 02:27:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Running setup.py install for moznetwork 02:27:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Running setup.py install for mozprocess 02:27:07 INFO - Running setup.py install for mozprofile 02:27:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Running setup.py install for mozrunner 02:27:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:07 INFO - Running setup.py install for mozscreenshot 02:27:07 INFO - Running setup.py install for moztest 02:27:07 INFO - Running setup.py install for mozversion 02:27:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:08 INFO - Cleaning up... 02:27:08 INFO - Return code: 0 02:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:08 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 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:08 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 02:27:08 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 02:27:08 INFO - Using env: {'DISPLAY': ':0', 02:27:08 INFO - 'HOME': '/home/cltbld', 02:27:08 INFO - 'LANG': 'en_US.UTF-8', 02:27:08 INFO - 'LANGUAGE': 'en_US:en', 02:27:08 INFO - 'LOGNAME': 'cltbld', 02:27:08 INFO - 'MAIL': '/var/mail/cltbld', 02:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:08 INFO - 'MOZ_NO_REMOTE': '1', 02:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:08 INFO - 'NO_EM_RESTART': '1', 02:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:08 INFO - 'PWD': '/builds/slave/test', 02:27:08 INFO - 'SHELL': '/bin/bash', 02:27:08 INFO - 'SHLVL': '1', 02:27:08 INFO - 'TERM': 'linux', 02:27:08 INFO - 'TMOUT': '86400', 02:27:08 INFO - 'USER': 'cltbld', 02:27:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:08 INFO - '_': '/tools/buildbot/bin/python'} 02:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:08 INFO - Running setup.py (path:/tmp/pip-EoCXTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:08 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)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:08 INFO - Running setup.py (path:/tmp/pip-JkIPrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:08 INFO - Running setup.py (path:/tmp/pip-lUhlxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:08 INFO - Running setup.py (path:/tmp/pip-aWJkfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:08 INFO - Running setup.py (path:/tmp/pip-xUcQyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:08 INFO - Running setup.py (path:/tmp/pip-IQnTQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:08 INFO - Running setup.py (path:/tmp/pip-R5cB5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:08 INFO - Running setup.py (path:/tmp/pip-Xtosv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:08 INFO - Running setup.py (path:/tmp/pip-u1gy6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:08 INFO - Running setup.py (path:/tmp/pip-xDrV5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:08 INFO - Running setup.py (path:/tmp/pip-hJIEL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:09 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)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:09 INFO - Running setup.py (path:/tmp/pip-jF4_rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:09 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)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:09 INFO - Running setup.py (path:/tmp/pip-DfNNsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:09 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)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:09 INFO - Running setup.py (path:/tmp/pip-J0xp2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:09 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)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:09 INFO - Running setup.py (path:/tmp/pip-77hlDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:09 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)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:09 INFO - Running setup.py (path:/tmp/pip-G0Yt82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:09 INFO - Running setup.py (path:/tmp/pip-p4W9YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - Downloading blessings-1.6.tar.gz 02:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:11 INFO - Installing collected packages: blessings 02:27:11 INFO - Running setup.py install for blessings 02:27:11 INFO - Successfully installed blessings 02:27:11 INFO - Cleaning up... 02:27:11 INFO - Return code: 0 02:27:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:11 INFO - Reading from file tmpfile_stdout 02:27:11 INFO - Current package versions: 02:27:11 INFO - argparse == 1.2.1 02:27:11 INFO - blessings == 1.6 02:27:11 INFO - blobuploader == 1.2.4 02:27:11 INFO - docopt == 0.6.1 02:27:11 INFO - manifestparser == 1.1 02:27:11 INFO - mozInstall == 1.12 02:27:11 INFO - mozcrash == 0.17 02:27:11 INFO - mozdebug == 0.1 02:27:11 INFO - mozdevice == 0.48 02:27:11 INFO - mozfile == 1.2 02:27:11 INFO - mozhttpd == 0.7 02:27:11 INFO - mozinfo == 0.9 02:27:11 INFO - mozleak == 0.1 02:27:11 INFO - mozlog == 3.2 02:27:11 INFO - moznetwork == 0.27 02:27:11 INFO - mozprocess == 0.22 02:27:11 INFO - mozprofile == 0.28 02:27:11 INFO - mozrunner == 6.11 02:27:11 INFO - mozscreenshot == 0.1 02:27:11 INFO - mozsystemmonitor == 0.3 02:27:11 INFO - moztest == 0.7 02:27:11 INFO - mozversion == 1.4 02:27:11 INFO - psutil == 3.1.1 02:27:11 INFO - requests == 1.2.3 02:27:11 INFO - wsgiref == 0.1.2 02:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:27:11 INFO - Using env: {'DISPLAY': ':0', 02:27:11 INFO - 'HOME': '/home/cltbld', 02:27:11 INFO - 'LANG': 'en_US.UTF-8', 02:27:11 INFO - 'LANGUAGE': 'en_US:en', 02:27:11 INFO - 'LOGNAME': 'cltbld', 02:27:11 INFO - 'MAIL': '/var/mail/cltbld', 02:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:11 INFO - 'MOZ_NO_REMOTE': '1', 02:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:11 INFO - 'NO_EM_RESTART': '1', 02:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:11 INFO - 'PWD': '/builds/slave/test', 02:27:11 INFO - 'SHELL': '/bin/bash', 02:27:11 INFO - 'SHLVL': '1', 02:27:11 INFO - 'TERM': 'linux', 02:27:11 INFO - 'TMOUT': '86400', 02:27:11 INFO - 'USER': 'cltbld', 02:27:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:11 INFO - '_': '/tools/buildbot/bin/python'} 02:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 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)) 02:27:12 INFO - Cleaning up... 02:27:12 INFO - Return code: 0 02:27:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27:12 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')]} 02:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:12 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')]} 02:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:12 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 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:12 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 02:27:12 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 02:27:12 INFO - Using env: {'DISPLAY': ':0', 02:27:12 INFO - 'HOME': '/home/cltbld', 02:27:12 INFO - 'LANG': 'en_US.UTF-8', 02:27:12 INFO - 'LANGUAGE': 'en_US:en', 02:27:12 INFO - 'LOGNAME': 'cltbld', 02:27:12 INFO - 'MAIL': '/var/mail/cltbld', 02:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:12 INFO - 'MOZ_NO_REMOTE': '1', 02:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:12 INFO - 'NO_EM_RESTART': '1', 02:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:12 INFO - 'PWD': '/builds/slave/test', 02:27:12 INFO - 'SHELL': '/bin/bash', 02:27:12 INFO - 'SHLVL': '1', 02:27:12 INFO - 'TERM': 'linux', 02:27:12 INFO - 'TMOUT': '86400', 02:27:12 INFO - 'USER': 'cltbld', 02:27:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:12 INFO - '_': '/tools/buildbot/bin/python'} 02:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:12 INFO - Downloading/unpacking jsonschema 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:14 INFO - Downloading/unpacking functools32 (from jsonschema) 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:14 INFO - warning: no files found matching '*.txt' 02:27:14 INFO - no previously-included directories found matching 'build' 02:27:14 INFO - no previously-included directories found matching 'dist' 02:27:14 INFO - no previously-included directories found matching '.git*' 02:27:14 INFO - Installing collected packages: jsonschema, functools32 02:27:14 INFO - Running setup.py install for functools32 02:27:14 INFO - warning: no files found matching '*.txt' 02:27:14 INFO - no previously-included directories found matching 'build' 02:27:14 INFO - no previously-included directories found matching 'dist' 02:27:14 INFO - no previously-included directories found matching '.git*' 02:27:14 INFO - Successfully installed jsonschema functools32 02:27:14 INFO - Cleaning up... 02:27:14 INFO - Return code: 0 02:27:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7608579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c01770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', '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 02:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:27:14 INFO - Using env: {'DISPLAY': ':0', 02:27:14 INFO - 'HOME': '/home/cltbld', 02:27:14 INFO - 'LANG': 'en_US.UTF-8', 02:27:14 INFO - 'LANGUAGE': 'en_US:en', 02:27:14 INFO - 'LOGNAME': 'cltbld', 02:27:14 INFO - 'MAIL': '/var/mail/cltbld', 02:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:14 INFO - 'MOZ_NO_REMOTE': '1', 02:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:14 INFO - 'NO_EM_RESTART': '1', 02:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:14 INFO - 'PWD': '/builds/slave/test', 02:27:14 INFO - 'SHELL': '/bin/bash', 02:27:14 INFO - 'SHLVL': '1', 02:27:14 INFO - 'TERM': 'linux', 02:27:14 INFO - 'TMOUT': '86400', 02:27:14 INFO - 'USER': 'cltbld', 02:27:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:14 INFO - '_': '/tools/buildbot/bin/python'} 02:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:14 INFO - Downloading/unpacking flake8 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:27:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:27:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:17 INFO - no previously-included directories found matching 'docs/_build' 02:27:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:27:17 INFO - Running setup.py install for pep8 02:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:17 INFO - no previously-included directories found matching 'docs/_build' 02:27:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:27:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:27:17 INFO - Cleaning up... 02:27:17 INFO - Return code: 0 02:27:17 INFO - Running post-action listener: _resource_record_post_action 02:27:17 INFO - Running post-action listener: _start_resource_monitoring 02:27:17 INFO - Starting resource monitoring. 02:27:17 INFO - ##### 02:27:17 INFO - ##### Finished create-virtualenv step (success) 02:27:17 INFO - ##### 02:27:17 INFO - ##### 02:27:17 INFO - ##### Running install step. 02:27:17 INFO - ##### 02:27:17 INFO - Running pre-action listener: _resource_record_pre_action 02:27:17 INFO - Running main action method: install 02:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:17 INFO - Reading from file tmpfile_stdout 02:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:17 INFO - Reading from file tmpfile_stdout 02:27:17 INFO - Output received: 02:27:17 INFO - Usage: mozinstall [options] installer 02:27:17 INFO - Options: 02:27:17 INFO - -h, --help show this help message and exit 02:27:17 INFO - -d DEST, --destination=DEST 02:27:17 INFO - Directory to install application into. [default: 02:27:17 INFO - "/builds/slave/test"] 02:27:17 INFO - --app=APP Application being installed. [default: firefox] 02:27:17 INFO - mkdir: /builds/slave/test/build/application 02:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:27:33 INFO - Reading from file tmpfile_stdout 02:27:33 INFO - Output received: 02:27:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:27:33 INFO - Running post-action listener: _resource_record_post_action 02:27:33 INFO - ##### 02:27:33 INFO - ##### Finished install step (success) 02:27:33 INFO - ##### 02:27:33 INFO - ##### 02:27:33 INFO - ##### Running run-tests step. 02:27:33 INFO - ##### 02:27:33 INFO - Running pre-action listener: _resource_record_pre_action 02:27:33 INFO - Running main action method: run_tests 02:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:33 INFO - Python 2.7.3 02:27:33 INFO - Return code: 0 02:27:33 INFO - grabbing minidump binary from tooltool 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c909c0>, '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 0x1c918c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c91d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:27:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:27:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:27:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:33 INFO - Return code: 0 02:27:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:27:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:27:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:27:34 INFO - Return code: 0 02:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 02:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 02:27:34 INFO - Using env: {'DISPLAY': ':0', 02:27:34 INFO - 'HOME': '/home/cltbld', 02:27:34 INFO - 'LANG': 'en_US.UTF-8', 02:27:34 INFO - 'LANGUAGE': 'en_US:en', 02:27:34 INFO - 'LOGNAME': 'cltbld', 02:27:34 INFO - 'MAIL': '/var/mail/cltbld', 02:27:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:34 INFO - 'MOZ_NO_REMOTE': '1', 02:27:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:34 INFO - 'NO_EM_RESTART': '1', 02:27:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:34 INFO - 'PWD': '/builds/slave/test', 02:27:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:34 INFO - 'SHELL': '/bin/bash', 02:27:34 INFO - 'SHLVL': '1', 02:27:34 INFO - 'TERM': 'linux', 02:27:34 INFO - 'TMOUT': '86400', 02:27:34 INFO - 'USER': 'cltbld', 02:27:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147', 02:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:34 INFO - '_': '/tools/buildbot/bin/python'} 02:27:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 02:27:34 INFO - mozversion application_buildid: 20160517065136 02:27:34 INFO - mozversion application_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 02:27:34 INFO - mozversion application_display_name: Nightly 02:27:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:34 INFO - mozversion application_name: Firefox 02:27:34 INFO - mozversion application_remotingname: firefox 02:27:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:27:34 INFO - mozversion application_vendor: Mozilla 02:27:34 INFO - mozversion application_version: 49.0a1 02:27:34 INFO - mozversion platform_buildid: 20160517065136 02:27:34 INFO - mozversion platform_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 02:27:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:27:34 INFO - mozversion platform_version: 49.0a1 02:27:34 INFO - using testdate: 1463650054 02:27:34 INFO - actual date: 1463650054 02:27:34 INFO - starting webserver on 'localhost:32800' 02:27:34 INFO - SUITE-START | Running 2 tests 02:27:34 INFO - TEST-START | dromaeo_css 02:27:34 INFO - operating with platform_type : linux_ 02:27:34 INFO - Initialising browser for dromaeo_css test... 02:27:34 INFO - TEST-INFO | started process 3254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhzN5n/profile http://localhost:32800/getInfo.html) 02:27:38 INFO - PROCESS | 3254 | 02:27:38 INFO - PROCESS | 3254 | (process:3326): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:27:39 INFO - PROCESS | 3254 | __metrics Screen width/height:1600/1200 02:27:39 INFO - PROCESS | 3254 | colorDepth:24 02:27:39 INFO - PROCESS | 3254 | Browser inner width/height: 1024/697 02:27:39 INFO - PROCESS | 3254 | __metrics 02:27:40 ERROR - PROCESS | 3254 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:27:41 INFO - TEST-INFO | 3254: exit 0 02:27:41 INFO - Browser initialized. 02:27:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:41 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhzN5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:42 INFO - PROCESS | 3377 | 02:27:42 INFO - PROCESS | 3377 | (process:3439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:27:53 INFO - PROCESS | 3377 | RSS: Main: 164679680 02:27:53 INFO - PROCESS | 3377 | 02:28:42 INFO - PROCESS | 3377 | 1463650122601 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] 02:30:54 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32800/tests/dromaeo/cssquery-ext.html) 02:30:55 INFO - PROCESS | 3377 | RSS: Main: 167211008 02:30:55 INFO - PROCESS | 3377 | 02:33:57 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-ext.html (next: http://localhost:32800/tests/dromaeo/cssquery-jquery.html) 02:33:58 INFO - PROCESS | 3377 | RSS: Main: 166551552 02:33:58 INFO - PROCESS | 3377 | 02:37:00 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32800/tests/dromaeo/cssquery-mootools.html) 02:37:01 INFO - PROCESS | 3377 | RSS: Main: 167337984 02:37:01 INFO - PROCESS | 3377 | 02:40:02 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32800/tests/dromaeo/cssquery-prototype.html) 02:40:03 INFO - PROCESS | 3377 | RSS: Main: 164982784 02:40:03 INFO - PROCESS | 3377 | 02:43:06 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32800/tests/dromaeo/cssquery-yui.html) 02:43:06 INFO - PROCESS | 3377 | RSS: Main: 165908480 02:43:06 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:32800/tests/dromaeo/cssquery-yui.html (next: http://localhost:32800/tests/dromaeo/cssquery-dojo.html) 02:46:09 INFO - PROCESS | 3377 | RSS: Main: 167698432 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | __start_tp_report 02:46:09 INFO - PROCESS | 3377 | _x_x_mozilla_page_load 02:46:09 INFO - PROCESS | 3377 | _x_x_mozilla_page_load_details 02:46:09 INFO - PROCESS | 3377 | |i|pagename|runs| 02:46:09 INFO - PROCESS | 3377 | |0;dojo.html;2600.1549496413663;2641.366072142686;2653.535631264528;2655.548556745353;2664.6535950326456;4593.885152871176;4615.930761038583;4656.813727450902;4698.483166851644;4710.882227944303;4584.7478388688605;4692.85921422357;4696.272077827934;4703.5061318561575;4734.834280800173;4257.084726783741;4310.008697999462;4420.712653677517;4431.512533621299;4439.334099885011;562.9243235410929;4300.80646370914;4334.60988511034;4418.9337159942625;4467.642588592905;4274.935875961863;4281.05816720321;4285.46431696038;4344.652427805768;4366.56334366564;4231.936520952188;4253.787310634487;4294.828206871722;4317.201317756225;4359.084592235603;4290.184864875664;4322.286822674255;4331.805068771912;4336.132773445323;4338.1540599583095;4659.62722982164;4669.836555720533;4699.718016918996;4706.270528068155;4785.114753770564;5068.2144267638205;5081.517255860687;5083.542481176675;5093.032323858492;5095.414027386861;5186.7925282988635;5189.532942035197;5193.506616871429;5196.480351964811;5237.79048838046;4795.088933102734;4817.229243321051;4844.903101937942;4853.538913803183;4869.050535145683;5186.455422180692;5233.764480598382;5260;5281.15501519755;5288.3918349390315;5001.224810154432;5004.149294619923;5009.474005229398;5027.145385284511;5082.313887625123;4990.950090499121;5120.590352771769;5123.8719032023755;5128.153854614022;5134.845954621367;4985.326980857611;5028.823991160292;5030.37120359955;5050.823221187241;5051.166557518042;4902.7058376497525;4951.356323677899;4959.156943319645;4999.775010124553;5007.123753343223;4117.21772863155;4285.357196420499;4289.656827453796;4294.914101717948;4343.022819865505;3725.273571653556;3732.8320225589914;3737.6262373762406;3761.3793724035777;3799.145192331703;4397.868063958086;4413.693077962333;4415.205263052617;4430.158269928703;4450.2434586120435;4942.777575009133;5093.159628661229;5118.564921981673;5148.613853960893;5156.458571849902;4397.582229688174;4440.378347031354;4448.755318457516;4485.0805584855025;4505.954940450619;4641.071785642885;4654.25531914892;4658.813647454132;4660.883477913079;4703.435587729426;4675.696079754805;4715.316279139574;4764.690295130806;4823.95176048235;4840.1287768201355;5084.3898732152375;5097.490250974873;5098;5099.388073431212;5129.256257842667;4763.071201115749;4768.76156192196;4770.522947705202;4778.331033655221;4818.590419814215;4850.5149485051215;4962.652614316963;4996.950030499794;5002.324686167321;5068.2904393384215;5088.465711100281;5099.745012749274;5110.386753589593;5126.769295381642;5162.741862906914;4975.129352363249;4976.800927962841;4978.4523702393435;4978.651494395358;4989.326440930428;4771.498992605726;4791;4929.260610908393;4931.605471562339;4973.801047958041;4782.306565548046;4810.4467986182035;4817.566419022305;4844.152273352079;4910.852674419773;5009;5016.598672106295;5029.874253143701;5030.0191462664425;5053.469385714594;4798.760061996956;4848.61211103118;4857.1742803724155;4875.756212189305;4929.457759646508 02:46:09 INFO - PROCESS | 3377 | |1;ext.html;563.3183847544472;590.8729623131027;592.4934181275013;612.7487730030687;616.9784057557987;36181.63818361815;39704;39745.60254397455;39946;40348.39477407841;39767.40348894769;39885.80057099718;39969.400458993136;40295.39556906649;40353.394699079465;7876.488028278158;7988.520688758664;7995.800104997364;8001.319887809544;8027.157148499411;7874.566898820592;7898.763037108896;7917.722879699211;7951.20487951206;7974.561399123046;8018.0779210390965;8054.59727013647;8056.476329038594;8056.8388632227325;8065.717699880505;7963.800904977364;7967.482113662622;7984.361251099898;7988.480748751342;7998.400119990994;7856.292933636;7921.841563168704;7944.801379965489;7948.642311096015;7949.96025019877;37515.812420938;37691.434628480594;38007;38321.42517862234;38374.42438363399;3215;3527.100589349725;3566.892993210208;3738.401855703102;3742.7941463219513;29344.559831602543;29772.553411698842;29968.40063198724;30180.698193018008;30277.848610757024;3512.9899160498885;3515.9648403515894;3629.1108678373703;3666.633336666339;3701.68535674468;262125.44686382802;266617;266778;268733;269404;33867.83066084703;55793.72103139458;55873;56363.43636563664;56473.71763141158;34296.657033429845;36326.27347453036;36348.63651363505;36394;36398.27203455916;13813.171209727248;13882.652933676738;13889.236092014835;13920.651983700285;13933.930330348283;11011.394373309546;11077.058450031838;11227;11264.26782259167;11281.153913456523;8300.294474969574;8368;8421.115782842835;8437.156284371515;8483.660653573788;3268.4770436730487;3272.8363581820813;3299.653536378694;3335.166208447888;3371.140359208386;889.7820034091689;977.8093271812071;980.67147505585;986.6694657289888;1048.124815778818;28909.132726017833;29103;29180.562291565642;29444.852775735984;29574.260643483656;1023.2070145637191;1024.4519182237468;1051.6897515233024;1105.9935458732514;1162.7441962768178;15264.23678816077;15307.92346038285;15356.923215383851;15576.610584735472;15714;364305;367690;367933;368025;369108;50960.745196274525;51938.480615193366;52335.73832130815;52443.73778131085;52461.7376913113;1260.357217818919;1274.4074005587447;1275.8979281657446;1277.4251586785983;1283.230061962815;27956.30109247285;28473.43053138967;28925.276868078465;28982.420351592427;29096;44586.10827783361;44986.32520512129;45105.548944510134;45160.54839451564;45378.09243815171;326444;330223;330398;330723;332264;25979.22062338133;26221.213363599123;26342.341441464116;26526.469470610864;26637.733622663527;40640.79679601583;43177.35233971556;43954.56045439505;44333.33499997438;44378.55621443744;37002;37926.431103532916;38006.80996594999;38191.23617527689;38444;37134.03015815357;37490.2501949954;37591;38338.42492362673;38423.15768423135;36979;37401.25197495981;39996.40005399863;40649;40816.38775418312;31959.247726496254;34063.14842128967;34316.48525272073;34356;34618.30763384768;25982;26045.479090417706;26326.078587249354;26555.468890622466;26582.468350633266 02:46:09 INFO - PROCESS | 3377 | |2;jquery.html;381.83581060144127;382.53904045625023;383.4862476466761;395.95644479107295;402.65371780268947;13665.795013074787;15392.538223853275;16536.338546458126;17980.64038719225;18055.458336249918;16567.91716041418;17087.14564271788;17692.557686057855;17731.64536709265;17867;4914.680545764514;5026.170681837492;5169.896602067956;5187.118189907725;5188.507091826271;5113.360829896263;5128.4358720540895;5147.279380886679;5157.922631160535;5159.406668233145;4965.404151501807;5074.644774865742;5149.459306772791;5165.173572228444;5191.325127733389;5144.6655967362;5145.511176438251;5147.897042059175;5189.117849965496;5194.974025129869;4472.396226509412;4609.147307748044;4610.308453731967;4639.39687840582;4644.976775116136;20846.270380536607;21047.47381315464;21337.146514139415;21451.46371340729;21501.46246343854;1938.3506525313896;2103.2323202031303;2316;2350.96557514693;2570.177543186181;12948.417321220568;13558.728825423435;13652.658683532893;13761.31193440324;14056.086354387035;1776.635789663116;1790.3465235189192;1798.154867212421;1828.9268429262813;1907.6089401672623;68324.3167568323;68740;69114;69343.65328173326;69344.6532767333;9807.362521436084;10076.395416275047;10304.124149447382;10830.945845270724;11007.61473348445;11983.16117871758;12769.233845969271;14103.929480352532;14121.223332716594;14145.717085658229;7232.168300645388;7501.987231723757;7602.885956710654;7837.275799324139;7852.764417067498;7273.27267273279;7400;7448.553086814808;7548.7357942472845;7566.24337566239;6309.179806625109;6340.953742632414;6438.45273151778;6490.772822951269;6494.318096599884;1840.1259401784046;1855.5639424735177;1875.2405275863298;1881;1902.2200897631903;837.7277384849948;882.289756745813;887.8268737596106;927.7309580221795;993.513178542509;16734.74897876533;16769.91615041917;17248;17355.132243388034;17797;886.348533827649;915.1626261970356;946.9384490008127;971.9028097190366;972.5380444288907;9618.903810961801;10070;10155.187584993182;10162.745931351628;10263.897361026444;367520;371494;372310;373407;375494;78087;79507.60246198732;81663.59168204121;81694;82855.585722071;904.8326059678849;932.8740620016347;945.413843417072;955.1499165742495;959.4051687953374;14541.127532348093;16088.436904708278;16266;16269.430569929995;16385.42651007209;28259.858700707187;33432;36049.27901442009;38388.42417363798;38394.23211535698;47594.762026189645;48496;48786.5121348782;50333;50641.240381395044;7526.661300241392;7843.607819608883;7866.292033716993;7964.084130325086;8104.635291412019;8870.467771933705;11457.942710286728;12072.39638018078;12101.75796484083;12303.569375072188;10515.842262366225;10717.732056698645;10724.463776811284;10946.507407166537;11169.553217871195;10575.312604680672;10634.30876992993;10669.839952400875;10745.194110441904;10857.185711071543;10420.32267902584;10603.522841471999;10647.201459890384;10726.785464290826;11050;7615.504992175491;7871.448998570045;8067.636956337096;8119.634616442392;8129.146439623991;7512.586807725627;7642.426817988562;10778.245522813328;10998.06516446111;11046.392448415414 02:46:09 INFO - PROCESS | 3377 | |3;mootools.html;1498.3856618786297;1542.714597799407;1700.3708627807714;1808.8552915766722;1830.1306879232375;7026.332498412643;7527.661255243514;7711.652975616097;8249.092599814016;8272.62773175207;7566.394688424926;7776.494527855685;7822.413319001069;7844.568548729818;7861.606919654023;2165.1123039553786;2196.901139448729;2197.044285735702;2200.6038912995655;2202.812760915324;2153.450870028141;2199.1643175593254;2200.7799220077945;2201.8458707890454;2207.8012978831903;2178.5533965537106;2180.1715348167672;2181.683655869898;2187.857789243702;2188.9452763680874;2071.741032370961;2072.6062048210792;2083.0626218201796;2091.633964056284;2100.5063810004635;2061.845361597871;2102.547952190271;2103.4951611613255;2106.9157233710635;2110.0926601561323;7614.885776713354;7719.575423351714;7750.341220996165;7767.456278060538;7769.106552746393;4451.154280686659;4564.863054108382;4569.428821397325;4575.267957126844;4579.335996280521;2800.313923088836;2912.606798082253;2945.617069780936;2953.601263829377;2958.9852050739823;873.4977388001861;883.0683628771643;883.960221790021;1771.7962434319961;1842.3275504440917;10601.045905868508;10659.786804263871;10661.200409969206;10664.360138391721;10688.679339619746;4022.336314508132;4117.114820313587;4122;4190.07818279984;4194.6853985951175;8729.60716767747;8746.781330466662;8755.56222188888;8773.517456539952;8776.210141087333;4723.881902952454;4739.289106634033;4763.737994410271;4770.045990801854;4782.163121453732;3793.6585707286476;4228.112096459717;4363.345498175236;4388.2320593896575;4415.823367065282;3402.9829850850588;3452.9309413811584;3541.575010998645;3567.500549923013;3661.4324779659196;961.7739831139677;1003.0120331473493;1009.5305682857506;1015.2436434855932;1024.2420608749471;919.6367434863191;920.497127772117;931.2968708625081;961.0677642686583;970.6020531582018;5416;5511.22842802008;5539.806106786243;5611.719414029282;5671.2060311556415;924.117467818232;937.920276776468;958.8322043642335;969.3650658818344;990.3562684255292;3728.7017038636845;3778.7732736035928;3796.981015094907;3819.84720611178;3898.5516665583255;9575.569099390545;9730.659426920023;10026.448545330077;10032.598696052077;10034.498275086216;9920.15678667307;9924.057214564606;10031.498425078717;10035.598576057022;10048.09567138961;7307.926920730831;7332.010178625924;7455.366293864974;7503.287187717158;7538.547687138789;5424.511793938565;5462.153366228241;5480.150576660624;5502.394736578893;5614.410486898817;8912.28701703875;8958.148975847284;9018.233450156547;9054.592543335433;9063;8821.294296456139;9183.44899306017;9186.632534698538;9216.769580760534;9257.35198536096;5987.371326010706;6439.291677915519;6529.118568993315;6693.163354580677;6694.531382803157;7918.524888506708;7932.325752311118;7967.362610991223;7996.1204267529365;8016.559089250147;6997.300269972962;7259.637018148966;7267.709291628275;7269.709211631475;7343;7112.35988761014;7147.1780745214965;7166.068411106523;7210;7293.708251669874;6418.133551970424;6609.669516524058;6700.162479690039;6782.287859774653;6839.62382068991;4827.179379505422;4849.612031037579;4891.364122664031;4907.435644900882;4919.975400122977;4979.228219625964;5114.488551144856;5130.538251557377;5140.742962851918;5142.357205349332 02:46:09 INFO - PROCESS | 3377 | |4;prototype.html;292.6108275992928;296.6618055416825;304.22422821804406;305.1029971882666;305.8165100939435;5052.090623687739;5079.542841144296;5092.592592592593;5101.234814777785;5126.974365128179;4999.425066117397;5001.899962000758;5004.499550044994;5008.749562521868;5021.447640759523;3971.907725375523;3974.6025397460166;3986.1230529283657;3987.122832976755;3988.361862102064;3871.49670542829;3947.539410418149;3948.881533553998;3989.880303590897;4001.2197621463824;3861.1698484825756;3881.243157584272;3889.3388124018843;3896.08442016126;3920.666743326806;3887.086534664366;3895.2014836958356;3921.098147426108;3923.5487918889407;3932.075962148893;3224.774265801395;3304.7190988765983;3398.7254779457703;3406.7615266931325;3429.2798512312443;4744.83393081244;4789.928151077736;4799.256115302133;4801.5438533339275;4826.80380426905;4432.578905004019;4440.978574927784;4442.623196589809;4450.421445212134;4458.464984201916;5011.173156429185;5210.358736997871;5221.347331583552;5249.186376111708;5260.710660913648;3792.2984247914223;3803.4675145479655;3815.3704638734575;3821.2739579479808;3826.368649172883;5478.178273259004;5483;5514.3658479275;5525.254090697745;5547.639403438763;3512.2799826035603;3731.2350968051483;3759.5112635357227;3886.6113388661474;3888.8444462221196;3786.7917264550165;3794;3811.9618803812164;3818.1790914953417;3827.119762454651;4390.802413891319;4403.339499075164;4414;4414.161309351213;4448.599626033672;5005.1491246488185;5275.683458992473;5293.708846013506;5323.494268044529;5325.8402247931845;1316.5984374765596;1325.8143859859626;1328.249539010456;1328.6611913961879;1334.838690339411;811.5049819610033;838.714836955438;841.6465084664455;845.560308639504;846.2341580869323;4204.768737719455;4222.725522841006;4240.427542281815;4246.44796176495;4268.551802060801;4939.753012349368;4950.25746138075;4954.232094025432;4964.90070198594;4995.675281106716;4257.382679511516;4262.9129571959575;4275.403940763691;4277.893052673708;4283.764392958417;2497.163450244152;2648.3511539672904;2792.720727927191;2803.215099772067;2905.3608206194604;5049.368828896388;5110.310108135429;5111.8722031948755;5115.283860259567;5126.589872810241;5567.721613919288;5593.133064375028;5595.244641973363;5596.888062238732;5598.188262701967;4957.3307603473795;5069.417017043013;5091.236314552847;5108;5108.693478391308;5401.108817045144;5406.189071639285;5413.48422441717;5416.079266524779;5435.918461223006;5193.246979187921;5315.3621565412395;5380.973095134499;5381.300430943952;5405.297311349499;5140.920406714632;5156.767945442389;5163.4062082860955;5183.900520289289;5188.896222075462;3781.0925377909653;3790.7346485745734;3791.1848952474247;3797.6012518686243;3816.9809150954065;5241.44964778708;5440.918386224289;5460.426655201147;5498.642588231752;5499.780008799603;5242.501962313574;5268.604854635841;5273.077211488051;5283.867903302448;5286.233496142961;5285.973570132125;5306.681599104066;5307.805743707635;5310.389305229948;5314.867128321823;4913.434954980223;5161.535461808456;5162.948370516397;5187.2478490619405;5191.662541934762;5262.921056184084;5375.462453754593;5388.38033626138;5391.9460805391445;5407.891842163213;5232.476752324737;5250.947490525045;5253.553447956813;5269;5272.209168624737 02:46:09 INFO - PROCESS | 3377 | |5;yui.html;684.4182444921817;687.7730348984833;699.9510034297595;730.1566690472503;820.0774129104757;12385;13170.60488185356;13184.802227966587;13191.868081319184;13241.801372979413;11934.7613047739;12470.251784892913;12591.370431478435;12604.684882877933;12631.431585578648;880.7137680253911;890.6526454682679;894.9284057275435;894.9910500895005;895.8880139982502;877.789330560664;882.3162049411693;884.7434244069212;885.9025507194203;889.5730049576207;929.6420877961966;932.0818993291637;932.7528205025674;934.3272843552666;934.7943452440452;918.8346097702411;919.1589695428709;922.423485321674;925.5973651461636;926.972190834276;677.1637028270083;678.4504551313452;678.9287124851869;679.3647939176885;683.3917813146304;12230.266184028987;12232.388380580935;12293.200941938745;12326.260424374566;12326.445309961073;12509.437075331633;12521.56174533896;12567;12687.365631718378;12967.43424991022;9665.130138287588;9842.458664773434;9890.653827116088;9933.602655893756;10094.949525252327;2942.955855662167;2975.5685425613165;3022.879084836604;3025.319303156794;3268.3626692794915;42342.57657423448;43378.13243735139;43731.12537749259;43754.34368484475;43870.122597547874;9533.47565883883;9640;9676.12914837654;9773.804523909625;9825.754356141153;17551.297948081934;17560.560985975197;17571.73642395365;17578;17594;6990.790276291719;7113.359797618239;7191.7842464726145;7274.27257274279;7379.298966598165;3758.361078616642;3837.194189220239;3858.401947698111;3893.824777885002;3922.470466486988;2960.851957402121;3094.257378229209;3101.9069427917198;3104.239461331988;3106.409782141386;523.4739087217322;539.0889396919194;541.7859945321654;545.4109561673463;547.2147468382883;476.3188640244484;583.3437382944188;586.6274915428648;603.5714642603713;617.5245061302771;7632.656530456143;7648.464607477423;7762.456628036096;7766.110070537591;8030.959845200737;590.4361334925136;623.4669357699192;631.4853394483481;635.9841003974938;639.0892977507034;3557.0929413000035;3684.5394325709285;3766.133789228438;3795.8102094895144;3829.7702137871815;52833;54035;54401.455985439636;54411;54850.17724734132;39596.60403395987;47760.5223947763;48365.516344836804;49532.75233623881;54199.45800541944;47461.76269118701;47463;47682.5231747685;48859;49129.508704913205;8161.143079976754;8510.70212542558;8550;8734.344924130843;8836.911630883866;31147;31675.366492670477;31704.36591268208;32324.83837580797;33219.16952076121;41712.3743143847;41784.79107604443;41940.790296048326;41997.37003945004;42077;10986.835197472205;11159.832602511131;11167.329960202089;11199.832002520132;11206.047485963785;11904.821427678766;12425.633180349974;12561.497540098293;12640.55758048464;12901.612951611467;11028.558857645605;11354.318740875575;11600.477978491157;11718.88281117212;12320.75358492843;11432;11474.94262528682;11575.189736718348;11930.463129159381;11940.04479641644;11239.662810115382;11380.089592832719;11619.36093514831;11622.70943226426;11756.23584467007;8955.865662014945;9199.264058875407;9312.805852515872;9344.95327523358;9510.38182518134;8855.690050848189;8987.865182022144;9058.275337973078;9191.034941331063;9221.614281720538 02:46:09 INFO - PROCESS | 3377 | __end_tp_report 02:46:09 INFO - PROCESS | 3377 | __start_cc_report 02:46:09 INFO - PROCESS | 3377 | _x_x_mozilla_cycle_collect,387 02:46:09 INFO - PROCESS | 3377 | __end_cc_report 02:46:09 INFO - PROCESS | 3377 | __startTimestamp1463651169472__endTimestamp 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | ------- Summary: start ------- 02:46:09 INFO - PROCESS | 3377 | Number of tests: 6 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#0] dojo.html Cycles:165 Average:4668.46 Median:4817.23 stddev:593.80 (12.3%) stddev-sans-first:573.03 02:46:09 INFO - PROCESS | 3377 | Values: 2600.2 2641.4 2653.5 2655.5 2664.7 4593.9 4615.9 4656.8 4698.5 4710.9 4584.7 4692.9 4696.3 4703.5 4734.8 4257.1 4310.0 4420.7 4431.5 4439.3 562.9 4300.8 4334.6 4418.9 4467.6 4274.9 4281.1 4285.5 4344.7 4366.6 4231.9 4253.8 4294.8 4317.2 4359.1 4290.2 4322.3 4331.8 4336.1 4338.2 4659.6 4669.8 4699.7 4706.3 4785.1 5068.2 5081.5 5083.5 5093.0 5095.4 5186.8 5189.5 5193.5 5196.5 5237.8 4795.1 4817.2 4844.9 4853.5 4869.1 5186.5 5233.8 5260.0 5281.2 5288.4 5001.2 5004.1 5009.5 5027.1 5082.3 4991.0 5120.6 5123.9 5128.2 5134.8 4985.3 5028.8 5030.4 5050.8 5051.2 4902.7 4951.4 4959.2 4999.8 5007.1 4117.2 4285.4 4289.7 4294.9 4343.0 3725.3 3732.8 3737.6 3761.4 3799.1 4397.9 4413.7 4415.2 4430.2 4450.2 4942.8 5093.2 5118.6 5148.6 5156.5 4397.6 4440.4 4448.8 4485.1 4506.0 4641.1 4654.3 4658.8 4660.9 4703.4 4675.7 4715.3 4764.7 4824.0 4840.1 5084.4 5097.5 5098.0 5099.4 5129.3 4763.1 4768.8 4770.5 4778.3 4818.6 4850.5 4962.7 4997.0 5002.3 5068.3 5088.5 5099.7 5110.4 5126.8 5162.7 4975.1 4976.8 4978.5 4978.7 4989.3 4771.5 4791.0 4929.3 4931.6 4973.8 4782.3 4810.4 4817.6 4844.2 4910.9 5009.0 5016.6 5029.9 5030.0 5053.5 4798.8 4848.6 4857.2 4875.8 4929.5 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#1] ext.html Cycles:180 Average:47270.67 Median:36990.50 stddev:85278.03 (230.5%) stddev-sans-first:85445.15 02:46:09 INFO - PROCESS | 3377 | Values: 563.3 590.9 592.5 612.7 617.0 36181.6 39704.0 39745.6 39946.0 40348.4 39767.4 39885.8 39969.4 40295.4 40353.4 7876.5 7988.5 7995.8 8001.3 8027.2 7874.6 7898.8 7917.7 7951.2 7974.6 8018.1 8054.6 8056.5 8056.8 8065.7 7963.8 7967.5 7984.4 7988.5 7998.4 7856.3 7921.8 7944.8 7948.6 7950.0 37515.8 37691.4 38007.0 38321.4 38374.4 3215.0 3527.1 3566.9 3738.4 3742.8 29344.6 29772.6 29968.4 30180.7 30277.8 3513.0 3516.0 3629.1 3666.6 3701.7 262125.4 266617.0 266778.0 268733.0 269404.0 33867.8 55793.7 55873.0 56363.4 56473.7 34296.7 36326.3 36348.6 36394.0 36398.3 13813.2 13882.7 13889.2 13920.7 13933.9 11011.4 11077.1 11227.0 11264.3 11281.2 8300.3 8368.0 8421.1 8437.2 8483.7 3268.5 3272.8 3299.7 3335.2 3371.1 889.8 977.8 980.7 986.7 1048.1 28909.1 29103.0 29180.6 29444.9 29574.3 1023.2 1024.5 1051.7 1106.0 1162.7 15264.2 15307.9 15356.9 15576.6 15714.0 364305.0 367690.0 367933.0 368025.0 369108.0 50960.7 51938.5 52335.7 52443.7 52461.7 1260.4 1274.4 1275.9 1277.4 1283.2 27956.3 28473.4 28925.3 28982.4 29096.0 44586.1 44986.3 45105.5 45160.5 45378.1 326444.0 330223.0 330398.0 330723.0 332264.0 25979.2 26221.2 26342.3 26526.5 26637.7 40640.8 43177.4 43954.6 44333.3 44378.6 37002.0 37926.4 38006.8 38191.2 38444.0 37134.0 37490.3 37591.0 38338.4 38423.2 36979.0 37401.3 39996.4 40649.0 40816.4 31959.2 34063.1 34316.5 34356.0 34618.3 25982.0 26045.5 26326.1 26555.5 26582.5 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#2] jquery.html Cycles:180 Average:24057.00 Median:19385.96 stddev:61558.89 (317.5%) stddev-sans-first:61705.91 02:46:09 INFO - PROCESS | 3377 | Values: 381.8 382.5 383.5 396.0 402.7 13665.8 15392.5 16536.3 17980.6 18055.5 16567.9 17087.1 17692.6 17731.6 17867.0 4914.7 5026.2 5169.9 5187.1 5188.5 5113.4 5128.4 5147.3 5157.9 5159.4 4965.4 5074.6 5149.5 5165.2 5191.3 5144.7 5145.5 5147.9 5189.1 5195.0 4472.4 4609.1 4610.3 4639.4 4645.0 20846.3 21047.5 21337.1 21451.5 21501.5 1938.4 2103.2 2316.0 2351.0 2570.2 12948.4 13558.7 13652.7 13761.3 14056.1 1776.6 1790.3 1798.2 1828.9 1907.6 68324.3 68740.0 69114.0 69343.7 69344.7 9807.4 10076.4 10304.1 10830.9 11007.6 11983.2 12769.2 14103.9 14121.2 14145.7 7232.2 7502.0 7602.9 7837.3 7852.8 7273.3 7400.0 7448.6 7548.7 7566.2 6309.2 6341.0 6438.5 6490.8 6494.3 1840.1 1855.6 1875.2 1881.0 1902.2 837.7 882.3 887.8 927.7 993.5 16734.7 16769.9 17248.0 17355.1 17797.0 886.3 915.2 946.9 971.9 972.5 9618.9 10070.0 10155.2 10162.7 10263.9 367520.0 371494.0 372310.0 373407.0 375494.0 78087.0 79507.6 81663.6 81694.0 82855.6 904.8 932.9 945.4 955.1 959.4 14541.1 16088.4 16266.0 16269.4 16385.4 28259.9 33432.0 36049.3 38388.4 38394.2 47594.8 48496.0 48786.5 50333.0 50641.2 7526.7 7843.6 7866.3 7964.1 8104.6 8870.5 11457.9 12072.4 12101.8 12303.6 10515.8 10717.7 10724.5 10946.5 11169.6 10575.3 10634.3 10669.8 10745.2 10857.2 10420.3 10603.5 10647.2 10726.8 11050.0 7615.5 7871.4 8067.6 8119.6 8129.1 7512.6 7642.4 10778.2 10998.1 11046.4 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#3] mootools.html Cycles:180 Average:5253.82 Median:5141.55 stddev:2909.75 (56.6%) stddev-sans-first:2904.23 02:46:09 INFO - PROCESS | 3377 | Values: 1498.4 1542.7 1700.4 1808.9 1830.1 7026.3 7527.7 7711.7 8249.1 8272.6 7566.4 7776.5 7822.4 7844.6 7861.6 2165.1 2196.9 2197.0 2200.6 2202.8 2153.5 2199.2 2200.8 2201.8 2207.8 2178.6 2180.2 2181.7 2187.9 2188.9 2071.7 2072.6 2083.1 2091.6 2100.5 2061.8 2102.5 2103.5 2106.9 2110.1 7614.9 7719.6 7750.3 7767.5 7769.1 4451.2 4564.9 4569.4 4575.3 4579.3 2800.3 2912.6 2945.6 2953.6 2959.0 873.5 883.1 884.0 1771.8 1842.3 10601.0 10659.8 10661.2 10664.4 10688.7 4022.3 4117.1 4122.0 4190.1 4194.7 8729.6 8746.8 8755.6 8773.5 8776.2 4723.9 4739.3 4763.7 4770.0 4782.2 3793.7 4228.1 4363.3 4388.2 4415.8 3403.0 3452.9 3541.6 3567.5 3661.4 961.8 1003.0 1009.5 1015.2 1024.2 919.6 920.5 931.3 961.1 970.6 5416.0 5511.2 5539.8 5611.7 5671.2 924.1 937.9 958.8 969.4 990.4 3728.7 3778.8 3797.0 3819.8 3898.6 9575.6 9730.7 10026.4 10032.6 10034.5 9920.2 9924.1 10031.5 10035.6 10048.1 7307.9 7332.0 7455.4 7503.3 7538.5 5424.5 5462.2 5480.2 5502.4 5614.4 8912.3 8958.1 9018.2 9054.6 9063.0 8821.3 9183.4 9186.6 9216.8 9257.4 5987.4 6439.3 6529.1 6693.2 6694.5 7918.5 7932.3 7967.4 7996.1 8016.6 6997.3 7259.6 7267.7 7269.7 7343.0 7112.4 7147.2 7166.1 7210.0 7293.7 6418.1 6609.7 6700.2 6782.3 6839.6 4827.2 4849.6 4891.4 4907.4 4920.0 4979.2 5114.5 5130.5 5140.7 5142.4 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#4] prototype.html Cycles:180 Average:4334.46 Median:4980.29 stddev:1280.90 (25.7%) stddev-sans-first:1248.05 02:46:09 INFO - PROCESS | 3377 | Values: 292.6 296.7 304.2 305.1 305.8 5052.1 5079.5 5092.6 5101.2 5127.0 4999.4 5001.9 5004.5 5008.7 5021.4 3971.9 3974.6 3986.1 3987.1 3988.4 3871.5 3947.5 3948.9 3989.9 4001.2 3861.2 3881.2 3889.3 3896.1 3920.7 3887.1 3895.2 3921.1 3923.5 3932.1 3224.8 3304.7 3398.7 3406.8 3429.3 4744.8 4789.9 4799.3 4801.5 4826.8 4432.6 4441.0 4442.6 4450.4 4458.5 5011.2 5210.4 5221.3 5249.2 5260.7 3792.3 3803.5 3815.4 3821.3 3826.4 5478.2 5483.0 5514.4 5525.3 5547.6 3512.3 3731.2 3759.5 3886.6 3888.8 3786.8 3794.0 3812.0 3818.2 3827.1 4390.8 4403.3 4414.0 4414.2 4448.6 5005.1 5275.7 5293.7 5323.5 5325.8 1316.6 1325.8 1328.2 1328.7 1334.8 811.5 838.7 841.6 845.6 846.2 4204.8 4222.7 4240.4 4246.4 4268.6 4939.8 4950.3 4954.2 4964.9 4995.7 4257.4 4262.9 4275.4 4277.9 4283.8 2497.2 2648.4 2792.7 2803.2 2905.4 5049.4 5110.3 5111.9 5115.3 5126.6 5567.7 5593.1 5595.2 5596.9 5598.2 4957.3 5069.4 5091.2 5108.0 5108.7 5401.1 5406.2 5413.5 5416.1 5435.9 5193.2 5315.4 5381.0 5381.3 5405.3 5140.9 5156.8 5163.4 5183.9 5188.9 3781.1 3790.7 3791.2 3797.6 3817.0 5241.4 5440.9 5460.4 5498.6 5499.8 5242.5 5268.6 5273.1 5283.9 5286.2 5286.0 5306.7 5307.8 5310.4 5314.9 4913.4 5161.5 5162.9 5187.2 5191.7 5262.9 5375.5 5388.4 5391.9 5407.9 5232.5 5250.9 5253.6 5269.0 5272.2 02:46:09 INFO - PROCESS | 3377 | 02:46:09 INFO - PROCESS | 3377 | [#5] yui.html Cycles:180 Average:13215.41 Median:47721.52 stddev:15102.60 (31.6%) stddev-sans-first:15115.65 02:46:09 INFO - PROCESS | 3377 | Values: 684.4 687.8 700.0 730.2 820.1 12385.0 13170.6 13184.8 13191.9 13241.8 11934.8 12470.3 12591.4 12604.7 12631.4 880.7 890.7 894.9 895.0 895.9 877.8 882.3 884.7 885.9 889.6 929.6 932.1 932.8 934.3 934.8 918.8 919.2 922.4 925.6 927.0 677.2 678.5 678.9 679.4 683.4 12230.3 12232.4 12293.2 12326.3 12326.4 12509.4 12521.6 12567.0 12687.4 12967.4 9665.1 9842.5 9890.7 9933.6 10094.9 2943.0 2975.6 3022.9 3025.3 3268.4 42342.6 43378.1 43731.1 43754.3 43870.1 9533.5 9640.0 9676.1 9773.8 9825.8 17551.3 17560.6 17571.7 17578.0 17594.0 6990.8 7113.4 7191.8 7274.3 7379.3 3758.4 3837.2 3858.4 3893.8 3922.5 2960.9 3094.3 3101.9 3104.2 3106.4 523.5 539.1 541.8 545.4 547.2 476.3 583.3 586.6 603.6 617.5 7632.7 7648.5 7762.5 7766.1 8031.0 590.4 623.5 631.5 636.0 639.1 3557.1 3684.5 3766.1 3795.8 3829.8 52833.0 54035.0 54401.5 54411.0 54850.2 39596.6 47760.5 48365.5 49532.8 54199.5 47461.8 47463.0 47682.5 48859.0 49129.5 8161.1 8510.7 8550.0 8734.3 8836.9 31147.0 31675.4 31704.4 32324.8 33219.2 41712.4 41784.8 41940.8 41997.4 42077.0 10986.8 11159.8 11167.3 11199.8 11206.0 11904.8 12425.6 12561.5 12640.6 12901.6 11028.6 11354.3 11600.5 11718.9 12320.8 11432.0 11474.9 11575.2 11930.5 11940.0 11239.7 11380.1 11619.4 11622.7 11756.2 8955.9 9199.3 9312.8 9345.0 9510.4 8855.7 8987.9 9058.3 9191.0 9221.6 02:46:09 INFO - PROCESS | 3377 | -------- Summary: end -------- 02:46:09 INFO - PROCESS | 3377 | 02:46:10 INFO - TEST-INFO | 3377: exit 0 02:46:10 INFO - TEST-OK | dromaeo_css | took 1115236ms 02:46:10 INFO - TEST-START | kraken 02:46:10 INFO - operating with platform_type : linux_ 02:46:10 INFO - Initialising browser for kraken test... 02:46:10 INFO - TEST-INFO | started process 3616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEpsnh/profile http://localhost:32800/getInfo.html) 02:46:13 INFO - PROCESS | 3616 | 02:46:13 INFO - PROCESS | 3616 | (process:3686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:46:14 INFO - PROCESS | 3616 | __metrics Screen width/height:1600/1200 02:46:14 INFO - PROCESS | 3616 | colorDepth:24 02:46:14 INFO - PROCESS | 3616 | Browser inner width/height: 1024/697 02:46:14 INFO - PROCESS | 3616 | __metrics 02:46:15 ERROR - PROCESS | 3616 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:46:16 INFO - TEST-INFO | 3616: exit 0 02:46:16 INFO - Browser initialized. 02:46:16 INFO - Running cycle 1/1 for kraken test... 02:46:16 INFO - TEST-INFO | started process 3737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEpsnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:18 INFO - PROCESS | 3737 | 02:46:18 INFO - PROCESS | 3737 | (process:3797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:46:28 INFO - PROCESS | 3737 | RSS: Main: 164556800 02:46:28 INFO - PROCESS | 3737 | 02:46:30 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:31 INFO - PROCESS | 3737 | RSS: Main: 167649280 02:46:31 INFO - PROCESS | 3737 | 02:46:34 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-dft) 02:46:35 INFO - PROCESS | 3737 | RSS: Main: 167878656 02:46:35 INFO - PROCESS | 3737 | 02:46:38 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-fft) 02:46:38 INFO - PROCESS | 3737 | RSS: Main: 164429824 02:46:38 INFO - PROCESS | 3737 | 02:46:41 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32800/tests/kraken/driver.html?testName=audio-oscillator) 02:46:41 INFO - PROCESS | 3737 | RSS: Main: 164397056 02:46:41 INFO - PROCESS | 3737 | 02:46:44 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:44 INFO - PROCESS | 3737 | RSS: Main: 164884480 02:46:44 INFO - PROCESS | 3737 | 02:46:47 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:48 INFO - PROCESS | 3737 | RSS: Main: 165089280 02:46:48 INFO - PROCESS | 3737 | 02:46:52 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32800/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:52 INFO - PROCESS | 3737 | RSS: Main: 163401728 02:46:52 INFO - PROCESS | 3737 | 02:46:55 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32800/tests/kraken/driver.html?testName=json-parse-financial) 02:46:56 INFO - PROCESS | 3737 | RSS: Main: 164003840 02:46:56 INFO - PROCESS | 3737 | 02:46:58 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:58 INFO - PROCESS | 3737 | RSS: Main: 164134912 02:46:58 INFO - PROCESS | 3737 | 02:47:00 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:01 INFO - PROCESS | 3737 | RSS: Main: 164151296 02:47:01 INFO - PROCESS | 3737 | 02:47:03 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:04 INFO - PROCESS | 3737 | RSS: Main: 164487168 02:47:04 INFO - PROCESS | 3737 | 02:47:07 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:07 INFO - PROCESS | 3737 | RSS: Main: 164708352 02:47:07 INFO - PROCESS | 3737 | 02:47:10 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:11 INFO - PROCESS | 3737 | RSS: Main: 164450304 02:47:11 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:32800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32800/tests/kraken/driver.html?testName=ai-astar) 02:47:13 INFO - PROCESS | 3737 | RSS: Main: 166010880 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | __start_tp_report 02:47:13 INFO - PROCESS | 3737 | _x_x_mozilla_page_load 02:47:13 INFO - PROCESS | 3737 | _x_x_mozilla_page_load_details 02:47:13 INFO - PROCESS | 3737 | |i|pagename|runs| 02:47:13 INFO - PROCESS | 3737 | |0;ai-astar;111;115;110;115;116;117;110;115;119;116 02:47:13 INFO - PROCESS | 3737 | |1;audio-beat-detection;162;130;161;215;133;166;153;133;184;132 02:47:13 INFO - PROCESS | 3737 | |2;audio-dft;163;164;168;168;165;163;165;166;162;164 02:47:13 INFO - PROCESS | 3737 | |3;audio-fft;76;76;76;167;76;75;75;77;164;77 02:47:13 INFO - PROCESS | 3737 | |4;audio-oscillator;94;94;175;93;94;93;152;93;94;139 02:47:13 INFO - PROCESS | 3737 | |5;imaging-gaussian-blur;119;118;117;117;118;118;117;117;118;117 02:47:13 INFO - PROCESS | 3737 | |6;imaging-darkroom;149;148;147;148;148;148;147;147;147;147 02:47:13 INFO - PROCESS | 3737 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;96;96 02:47:13 INFO - PROCESS | 3737 | |8;json-parse-financial;66;64;64;63;67;64;65;64;65;65 02:47:13 INFO - PROCESS | 3737 | |9;json-stringify-tinderbox;65;66;65;65;66;65;65;64;65;64 02:47:13 INFO - PROCESS | 3737 | |10;stanford-crypto-aes;82;83;83;82;84;88;83;82;138;86 02:47:13 INFO - PROCESS | 3737 | |11;stanford-crypto-ccm;144;147;129;130;136;133;134;133;147;136 02:47:13 INFO - PROCESS | 3737 | |12;stanford-crypto-pbkdf2;173;170;171;181;176;168;171;177;177;170 02:47:13 INFO - PROCESS | 3737 | |13;stanford-crypto-sha256-iterative;69;69;68;71;67;65;66;65;67;66 02:47:13 INFO - PROCESS | 3737 | __end_tp_report 02:47:13 INFO - PROCESS | 3737 | __start_cc_report 02:47:13 INFO - PROCESS | 3737 | _x_x_mozilla_cycle_collect,951 02:47:13 INFO - PROCESS | 3737 | __end_cc_report 02:47:13 INFO - PROCESS | 3737 | __startTimestamp1463651233579__endTimestamp 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | ------- Summary: start ------- 02:47:13 INFO - PROCESS | 3737 | Number of tests: 14 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:3.06 (2.7%) stddev-sans-first:2.99 02:47:13 INFO - PROCESS | 3737 | Values: 111.0 115.0 110.0 115.0 116.0 117.0 110.0 115.0 119.0 116.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:161.50 stddev:27.36 (16.9%) stddev-sans-first:28.96 02:47:13 INFO - PROCESS | 3737 | Values: 162.0 130.0 161.0 215.0 133.0 166.0 153.0 133.0 184.0 132.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.04 (1.2%) stddev-sans-first:2.06 02:47:13 INFO - PROCESS | 3737 | Values: 163.0 164.0 168.0 168.0 165.0 163.0 165.0 166.0 162.0 164.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.75 (49.7%) stddev-sans-first:39.48 02:47:13 INFO - PROCESS | 3737 | Values: 76.0 76.0 76.0 167.0 76.0 75.0 75.0 77.0 164.0 77.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:93.50 stddev:31.05 (33.2%) stddev-sans-first:32.24 02:47:13 INFO - PROCESS | 3737 | Values: 94.0 94.0 175.0 93.0 94.0 93.0 152.0 93.0 94.0 139.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 02:47:13 INFO - PROCESS | 3737 | Values: 119.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 02:47:13 INFO - PROCESS | 3737 | Values: 149.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:47:13 INFO - PROCESS | 3737 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 02:47:13 INFO - PROCESS | 3737 | Values: 66.0 64.0 64.0 63.0 67.0 64.0 65.0 64.0 65.0 65.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:47:13 INFO - PROCESS | 3737 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 64.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:83.00 stddev:17.29 (20.8%) stddev-sans-first:18.15 02:47:13 INFO - PROCESS | 3737 | Values: 82.0 83.0 83.0 82.0 84.0 88.0 83.0 82.0 138.0 86.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.00 stddev:6.71 (4.9%) stddev-sans-first:6.60 02:47:13 INFO - PROCESS | 3737 | Values: 144.0 147.0 129.0 130.0 136.0 133.0 134.0 133.0 147.0 136.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.50 stddev:4.14 (2.4%) stddev-sans-first:4.39 02:47:13 INFO - PROCESS | 3737 | Values: 173.0 170.0 171.0 181.0 176.0 168.0 171.0 177.0 177.0 170.0 02:47:13 INFO - PROCESS | 3737 | 02:47:13 INFO - PROCESS | 3737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.95 (2.9%) stddev-sans-first:1.96 02:47:13 INFO - PROCESS | 3737 | Values: 69.0 69.0 68.0 71.0 67.0 65.0 66.0 65.0 67.0 66.0 02:47:13 INFO - PROCESS | 3737 | -------- Summary: end -------- 02:47:13 INFO - PROCESS | 3737 | 02:47:14 INFO - TEST-INFO | 3737: exit 0 02:47:14 INFO - TEST-OK | kraken | took 64439ms 02:47:14 INFO - SUITE-END | took 1179s 02:47:14 INFO - Completed test suite (00:19:39) 02:47:14 INFO - javascript benchmark 02:47:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6404.876143803168, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.1549496413663, 2641.366072142686, 2653.535631264528, 2655.548556745353, 2664.6535950326456, 4593.885152871176, 4615.930761038583, 4656.813727450902, 4698.483166851644, 4710.882227944303, 4584.7478388688605, 4692.85921422357, 4696.272077827934, 4703.5061318561575, 4734.834280800173, 4257.084726783741, 4310.008697999462, 4420.712653677517, 4431.512533621299, 4439.334099885011, 562.9243235410929, 4300.80646370914, 4334.60988511034, 4418.9337159942625, 4467.642588592905, 4274.935875961863, 4281.05816720321, 4285.46431696038, 4344.652427805768, 4366.56334366564, 4231.936520952188, 4253.787310634487, 4294.828206871722, 4317.201317756225, 4359.084592235603, 4290.184864875664, 4322.286822674255, 4331.805068771912, 4336.132773445323, 4338.1540599583095, 4659.62722982164, 4669.836555720533, 4699.718016918996, 4706.270528068155, 4785.114753770564, 5068.2144267638205, 5081.517255860687, 5083.542481176675, 5093.032323858492, 5095.414027386861, 5186.7925282988635, 5189.532942035197, 5193.506616871429, 5196.480351964811, 5237.79048838046, 4795.088933102734, 4817.229243321051, 4844.903101937942, 4853.538913803183, 4869.050535145683, 5186.455422180692, 5233.764480598382, 5260.0, 5281.15501519755, 5288.3918349390315, 5001.224810154432, 5004.149294619923, 5009.474005229398, 5027.145385284511, 5082.313887625123, 4990.950090499121, 5120.590352771769, 5123.8719032023755, 5128.153854614022, 5134.845954621367, 4985.326980857611, 5028.823991160292, 5030.37120359955, 5050.823221187241, 5051.166557518042, 4902.7058376497525, 4951.356323677899, 4959.156943319645, 4999.775010124553, 5007.123753343223, 4117.21772863155, 4285.357196420499, 4289.656827453796, 4294.914101717948, 4343.022819865505, 3725.273571653556, 3732.8320225589914, 3737.6262373762406, 3761.3793724035777, 3799.145192331703, 4397.868063958086, 4413.693077962333, 4415.205263052617, 4430.158269928703, 4450.2434586120435, 4942.777575009133, 5093.159628661229, 5118.564921981673, 5148.613853960893, 5156.458571849902, 4397.582229688174, 4440.378347031354, 4448.755318457516, 4485.0805584855025, 4505.954940450619, 4641.071785642885, 4654.25531914892, 4658.813647454132, 4660.883477913079, 4703.435587729426, 4675.696079754805, 4715.316279139574, 4764.690295130806, 4823.95176048235, 4840.1287768201355, 5084.3898732152375, 5097.490250974873, 5098.0, 5099.388073431212, 5129.256257842667, 4763.071201115749, 4768.76156192196, 4770.522947705202, 4778.331033655221, 4818.590419814215, 4850.5149485051215, 4962.652614316963, 4996.950030499794, 5002.324686167321, 5068.2904393384215, 5088.465711100281, 5099.745012749274, 5110.386753589593, 5126.769295381642, 5162.741862906914, 4975.129352363249, 4976.800927962841, 4978.4523702393435, 4978.651494395358, 4989.326440930428, 4771.498992605726, 4791.0, 4929.260610908393, 4931.605471562339, 4973.801047958041, 4782.306565548046, 4810.4467986182035, 4817.566419022305, 4844.152273352079, 4910.852674419773, 5009.0, 5016.598672106295, 5029.874253143701, 5030.0191462664425, 5053.469385714594, 4798.760061996956, 4848.61211103118, 4857.1742803724155, 4875.756212189305, 4929.457759646508], "value": 4632.295999842353, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3183847544472, 590.8729623131027, 592.4934181275013, 612.7487730030687, 616.9784057557987, 36181.63818361815, 39704.0, 39745.60254397455, 39946.0, 40348.39477407841, 39767.40348894769, 39885.80057099718, 39969.400458993136, 40295.39556906649, 40353.394699079465, 7876.488028278158, 7988.520688758664, 7995.800104997364, 8001.319887809544, 8027.157148499411, 7874.566898820592, 7898.763037108896, 7917.722879699211, 7951.20487951206, 7974.561399123046, 8018.0779210390965, 8054.59727013647, 8056.476329038594, 8056.8388632227325, 8065.717699880505, 7963.800904977364, 7967.482113662622, 7984.361251099898, 7988.480748751342, 7998.400119990994, 7856.292933636, 7921.841563168704, 7944.801379965489, 7948.642311096015, 7949.96025019877, 37515.812420938, 37691.434628480594, 38007.0, 38321.42517862234, 38374.42438363399, 3215.0, 3527.100589349725, 3566.892993210208, 3738.401855703102, 3742.7941463219513, 29344.559831602543, 29772.553411698842, 29968.40063198724, 30180.698193018008, 30277.848610757024, 3512.9899160498885, 3515.9648403515894, 3629.1108678373703, 3666.633336666339, 3701.68535674468, 262125.44686382802, 266617.0, 266778.0, 268733.0, 269404.0, 33867.83066084703, 55793.72103139458, 55873.0, 56363.43636563664, 56473.71763141158, 34296.657033429845, 36326.27347453036, 36348.63651363505, 36394.0, 36398.27203455916, 13813.171209727248, 13882.652933676738, 13889.236092014835, 13920.651983700285, 13933.930330348283, 11011.394373309546, 11077.058450031838, 11227.0, 11264.26782259167, 11281.153913456523, 8300.294474969574, 8368.0, 8421.115782842835, 8437.156284371515, 8483.660653573788, 3268.4770436730487, 3272.8363581820813, 3299.653536378694, 3335.166208447888, 3371.140359208386, 889.7820034091689, 977.8093271812071, 980.67147505585, 986.6694657289888, 1048.124815778818, 28909.132726017833, 29103.0, 29180.562291565642, 29444.852775735984, 29574.260643483656, 1023.2070145637191, 1024.4519182237468, 1051.6897515233024, 1105.9935458732514, 1162.7441962768178, 15264.23678816077, 15307.92346038285, 15356.923215383851, 15576.610584735472, 15714.0, 364305.0, 367690.0, 367933.0, 368025.0, 369108.0, 50960.745196274525, 51938.480615193366, 52335.73832130815, 52443.73778131085, 52461.7376913113, 1260.357217818919, 1274.4074005587447, 1275.8979281657446, 1277.4251586785983, 1283.230061962815, 27956.30109247285, 28473.43053138967, 28925.276868078465, 28982.420351592427, 29096.0, 44586.10827783361, 44986.32520512129, 45105.548944510134, 45160.54839451564, 45378.09243815171, 326444.0, 330223.0, 330398.0, 330723.0, 332264.0, 25979.22062338133, 26221.213363599123, 26342.341441464116, 26526.469470610864, 26637.733622663527, 40640.79679601583, 43177.35233971556, 43954.56045439505, 44333.33499997438, 44378.55621443744, 37002.0, 37926.431103532916, 38006.80996594999, 38191.23617527689, 38444.0, 37134.03015815357, 37490.2501949954, 37591.0, 38338.42492362673, 38423.15768423135, 36979.0, 37401.25197495981, 39996.40005399863, 40649.0, 40816.38775418312, 31959.247726496254, 34063.14842128967, 34316.48525272073, 34356.0, 34618.30763384768, 25982.0, 26045.479090417706, 26326.078587249354, 26555.468890622466, 26582.468350633266], "value": 17136.704044943104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.83581060144127, 382.53904045625023, 383.4862476466761, 395.95644479107295, 402.65371780268947, 13665.795013074787, 15392.538223853275, 16536.338546458126, 17980.64038719225, 18055.458336249918, 16567.91716041418, 17087.14564271788, 17692.557686057855, 17731.64536709265, 17867.0, 4914.680545764514, 5026.170681837492, 5169.896602067956, 5187.118189907725, 5188.507091826271, 5113.360829896263, 5128.4358720540895, 5147.279380886679, 5157.922631160535, 5159.406668233145, 4965.404151501807, 5074.644774865742, 5149.459306772791, 5165.173572228444, 5191.325127733389, 5144.6655967362, 5145.511176438251, 5147.897042059175, 5189.117849965496, 5194.974025129869, 4472.396226509412, 4609.147307748044, 4610.308453731967, 4639.39687840582, 4644.976775116136, 20846.270380536607, 21047.47381315464, 21337.146514139415, 21451.46371340729, 21501.46246343854, 1938.3506525313896, 2103.2323202031303, 2316.0, 2350.96557514693, 2570.177543186181, 12948.417321220568, 13558.728825423435, 13652.658683532893, 13761.31193440324, 14056.086354387035, 1776.635789663116, 1790.3465235189192, 1798.154867212421, 1828.9268429262813, 1907.6089401672623, 68324.3167568323, 68740.0, 69114.0, 69343.65328173326, 69344.6532767333, 9807.362521436084, 10076.395416275047, 10304.124149447382, 10830.945845270724, 11007.61473348445, 11983.16117871758, 12769.233845969271, 14103.929480352532, 14121.223332716594, 14145.717085658229, 7232.168300645388, 7501.987231723757, 7602.885956710654, 7837.275799324139, 7852.764417067498, 7273.27267273279, 7400.0, 7448.553086814808, 7548.7357942472845, 7566.24337566239, 6309.179806625109, 6340.953742632414, 6438.45273151778, 6490.772822951269, 6494.318096599884, 1840.1259401784046, 1855.5639424735177, 1875.2405275863298, 1881.0, 1902.2200897631903, 837.7277384849948, 882.289756745813, 887.8268737596106, 927.7309580221795, 993.513178542509, 16734.74897876533, 16769.91615041917, 17248.0, 17355.132243388034, 17797.0, 886.348533827649, 915.1626261970356, 946.9384490008127, 971.9028097190366, 972.5380444288907, 9618.903810961801, 10070.0, 10155.187584993182, 10162.745931351628, 10263.897361026444, 367520.0, 371494.0, 372310.0, 373407.0, 375494.0, 78087.0, 79507.60246198732, 81663.59168204121, 81694.0, 82855.585722071, 904.8326059678849, 932.8740620016347, 945.413843417072, 955.1499165742495, 959.4051687953374, 14541.127532348093, 16088.436904708278, 16266.0, 16269.430569929995, 16385.42651007209, 28259.858700707187, 33432.0, 36049.27901442009, 38388.42417363798, 38394.23211535698, 47594.762026189645, 48496.0, 48786.5121348782, 50333.0, 50641.240381395044, 7526.661300241392, 7843.607819608883, 7866.292033716993, 7964.084130325086, 8104.635291412019, 8870.467771933705, 11457.942710286728, 12072.39638018078, 12101.75796484083, 12303.569375072188, 10515.842262366225, 10717.732056698645, 10724.463776811284, 10946.507407166537, 11169.553217871195, 10575.312604680672, 10634.30876992993, 10669.839952400875, 10745.194110441904, 10857.185711071543, 10420.32267902584, 10603.522841471999, 10647.201459890384, 10726.785464290826, 11050.0, 7615.504992175491, 7871.448998570045, 8067.636956337096, 8119.634616442392, 8129.146439623991, 7512.586807725627, 7642.426817988562, 10778.245522813328, 10998.06516446111, 11046.392448415414], "value": 8477.819718172454, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.3856618786297, 1542.714597799407, 1700.3708627807714, 1808.8552915766722, 1830.1306879232375, 7026.332498412643, 7527.661255243514, 7711.652975616097, 8249.092599814016, 8272.62773175207, 7566.394688424926, 7776.494527855685, 7822.413319001069, 7844.568548729818, 7861.606919654023, 2165.1123039553786, 2196.901139448729, 2197.044285735702, 2200.6038912995655, 2202.812760915324, 2153.450870028141, 2199.1643175593254, 2200.7799220077945, 2201.8458707890454, 2207.8012978831903, 2178.5533965537106, 2180.1715348167672, 2181.683655869898, 2187.857789243702, 2188.9452763680874, 2071.741032370961, 2072.6062048210792, 2083.0626218201796, 2091.633964056284, 2100.5063810004635, 2061.845361597871, 2102.547952190271, 2103.4951611613255, 2106.9157233710635, 2110.0926601561323, 7614.885776713354, 7719.575423351714, 7750.341220996165, 7767.456278060538, 7769.106552746393, 4451.154280686659, 4564.863054108382, 4569.428821397325, 4575.267957126844, 4579.335996280521, 2800.313923088836, 2912.606798082253, 2945.617069780936, 2953.601263829377, 2958.9852050739823, 873.4977388001861, 883.0683628771643, 883.960221790021, 1771.7962434319961, 1842.3275504440917, 10601.045905868508, 10659.786804263871, 10661.200409969206, 10664.360138391721, 10688.679339619746, 4022.336314508132, 4117.114820313587, 4122.0, 4190.07818279984, 4194.6853985951175, 8729.60716767747, 8746.781330466662, 8755.56222188888, 8773.517456539952, 8776.210141087333, 4723.881902952454, 4739.289106634033, 4763.737994410271, 4770.045990801854, 4782.163121453732, 3793.6585707286476, 4228.112096459717, 4363.345498175236, 4388.2320593896575, 4415.823367065282, 3402.9829850850588, 3452.9309413811584, 3541.575010998645, 3567.500549923013, 3661.4324779659196, 961.7739831139677, 1003.0120331473493, 1009.5305682857506, 1015.2436434855932, 1024.2420608749471, 919.6367434863191, 920.497127772117, 931.2968708625081, 961.0677642686583, 970.6020531582018, 5416.0, 5511.22842802008, 5539.806106786243, 5611.719414029282, 5671.2060311556415, 924.117467818232, 937.920276776468, 958.8322043642335, 969.3650658818344, 990.3562684255292, 3728.7017038636845, 3778.7732736035928, 3796.981015094907, 3819.84720611178, 3898.5516665583255, 9575.569099390545, 9730.659426920023, 10026.448545330077, 10032.598696052077, 10034.498275086216, 9920.15678667307, 9924.057214564606, 10031.498425078717, 10035.598576057022, 10048.09567138961, 7307.926920730831, 7332.010178625924, 7455.366293864974, 7503.287187717158, 7538.547687138789, 5424.511793938565, 5462.153366228241, 5480.150576660624, 5502.394736578893, 5614.410486898817, 8912.28701703875, 8958.148975847284, 9018.233450156547, 9054.592543335433, 9063.0, 8821.294296456139, 9183.44899306017, 9186.632534698538, 9216.769580760534, 9257.35198536096, 5987.371326010706, 6439.291677915519, 6529.118568993315, 6693.163354580677, 6694.531382803157, 7918.524888506708, 7932.325752311118, 7967.362610991223, 7996.1204267529365, 8016.559089250147, 6997.300269972962, 7259.637018148966, 7267.709291628275, 7269.709211631475, 7343.0, 7112.35988761014, 7147.1780745214965, 7166.068411106523, 7210.0, 7293.708251669874, 6418.133551970424, 6609.669516524058, 6700.162479690039, 6782.287859774653, 6839.62382068991, 4827.179379505422, 4849.612031037579, 4891.364122664031, 4907.435644900882, 4919.975400122977, 4979.228219625964, 5114.488551144856, 5130.538251557377, 5140.742962851918, 5142.357205349332], "value": 4260.296488492014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6108275992928, 296.6618055416825, 304.22422821804406, 305.1029971882666, 305.8165100939435, 5052.090623687739, 5079.542841144296, 5092.592592592593, 5101.234814777785, 5126.974365128179, 4999.425066117397, 5001.899962000758, 5004.499550044994, 5008.749562521868, 5021.447640759523, 3971.907725375523, 3974.6025397460166, 3986.1230529283657, 3987.122832976755, 3988.361862102064, 3871.49670542829, 3947.539410418149, 3948.881533553998, 3989.880303590897, 4001.2197621463824, 3861.1698484825756, 3881.243157584272, 3889.3388124018843, 3896.08442016126, 3920.666743326806, 3887.086534664366, 3895.2014836958356, 3921.098147426108, 3923.5487918889407, 3932.075962148893, 3224.774265801395, 3304.7190988765983, 3398.7254779457703, 3406.7615266931325, 3429.2798512312443, 4744.83393081244, 4789.928151077736, 4799.256115302133, 4801.5438533339275, 4826.80380426905, 4432.578905004019, 4440.978574927784, 4442.623196589809, 4450.421445212134, 4458.464984201916, 5011.173156429185, 5210.358736997871, 5221.347331583552, 5249.186376111708, 5260.710660913648, 3792.2984247914223, 3803.4675145479655, 3815.3704638734575, 3821.2739579479808, 3826.368649172883, 5478.178273259004, 5483.0, 5514.3658479275, 5525.254090697745, 5547.639403438763, 3512.2799826035603, 3731.2350968051483, 3759.5112635357227, 3886.6113388661474, 3888.8444462221196, 3786.7917264550165, 3794.0, 3811.9618803812164, 3818.1790914953417, 3827.119762454651, 4390.802413891319, 4403.339499075164, 4414.0, 4414.161309351213, 4448.599626033672, 5005.1491246488185, 5275.683458992473, 5293.708846013506, 5323.494268044529, 5325.8402247931845, 1316.5984374765596, 1325.8143859859626, 1328.249539010456, 1328.6611913961879, 1334.838690339411, 811.5049819610033, 838.714836955438, 841.6465084664455, 845.560308639504, 846.2341580869323, 4204.768737719455, 4222.725522841006, 4240.427542281815, 4246.44796176495, 4268.551802060801, 4939.753012349368, 4950.25746138075, 4954.232094025432, 4964.90070198594, 4995.675281106716, 4257.382679511516, 4262.9129571959575, 4275.403940763691, 4277.893052673708, 4283.764392958417, 2497.163450244152, 2648.3511539672904, 2792.720727927191, 2803.215099772067, 2905.3608206194604, 5049.368828896388, 5110.310108135429, 5111.8722031948755, 5115.283860259567, 5126.589872810241, 5567.721613919288, 5593.133064375028, 5595.244641973363, 5596.888062238732, 5598.188262701967, 4957.3307603473795, 5069.417017043013, 5091.236314552847, 5108.0, 5108.693478391308, 5401.108817045144, 5406.189071639285, 5413.48422441717, 5416.079266524779, 5435.918461223006, 5193.246979187921, 5315.3621565412395, 5380.973095134499, 5381.300430943952, 5405.297311349499, 5140.920406714632, 5156.767945442389, 5163.4062082860955, 5183.900520289289, 5188.896222075462, 3781.0925377909653, 3790.7346485745734, 3791.1848952474247, 3797.6012518686243, 3816.9809150954065, 5241.44964778708, 5440.918386224289, 5460.426655201147, 5498.642588231752, 5499.780008799603, 5242.501962313574, 5268.604854635841, 5273.077211488051, 5283.867903302448, 5286.233496142961, 5285.973570132125, 5306.681599104066, 5307.805743707635, 5310.389305229948, 5314.867128321823, 4913.434954980223, 5161.535461808456, 5162.948370516397, 5187.2478490619405, 5191.662541934762, 5262.921056184084, 5375.462453754593, 5388.38033626138, 5391.9460805391445, 5407.891842163213, 5232.476752324737, 5250.947490525045, 5253.553447956813, 5269.0, 5272.209168624737], "value": 3921.787123712275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4182444921817, 687.7730348984833, 699.9510034297595, 730.1566690472503, 820.0774129104757, 12385.0, 13170.60488185356, 13184.802227966587, 13191.868081319184, 13241.801372979413, 11934.7613047739, 12470.251784892913, 12591.370431478435, 12604.684882877933, 12631.431585578648, 880.7137680253911, 890.6526454682679, 894.9284057275435, 894.9910500895005, 895.8880139982502, 877.789330560664, 882.3162049411693, 884.7434244069212, 885.9025507194203, 889.5730049576207, 929.6420877961966, 932.0818993291637, 932.7528205025674, 934.3272843552666, 934.7943452440452, 918.8346097702411, 919.1589695428709, 922.423485321674, 925.5973651461636, 926.972190834276, 677.1637028270083, 678.4504551313452, 678.9287124851869, 679.3647939176885, 683.3917813146304, 12230.266184028987, 12232.388380580935, 12293.200941938745, 12326.260424374566, 12326.445309961073, 12509.437075331633, 12521.56174533896, 12567.0, 12687.365631718378, 12967.43424991022, 9665.130138287588, 9842.458664773434, 9890.653827116088, 9933.602655893756, 10094.949525252327, 2942.955855662167, 2975.5685425613165, 3022.879084836604, 3025.319303156794, 3268.3626692794915, 42342.57657423448, 43378.13243735139, 43731.12537749259, 43754.34368484475, 43870.122597547874, 9533.47565883883, 9640.0, 9676.12914837654, 9773.804523909625, 9825.754356141153, 17551.297948081934, 17560.560985975197, 17571.73642395365, 17578.0, 17594.0, 6990.790276291719, 7113.359797618239, 7191.7842464726145, 7274.27257274279, 7379.298966598165, 3758.361078616642, 3837.194189220239, 3858.401947698111, 3893.824777885002, 3922.470466486988, 2960.851957402121, 3094.257378229209, 3101.9069427917198, 3104.239461331988, 3106.409782141386, 523.4739087217322, 539.0889396919194, 541.7859945321654, 545.4109561673463, 547.2147468382883, 476.3188640244484, 583.3437382944188, 586.6274915428648, 603.5714642603713, 617.5245061302771, 7632.656530456143, 7648.464607477423, 7762.456628036096, 7766.110070537591, 8030.959845200737, 590.4361334925136, 623.4669357699192, 631.4853394483481, 635.9841003974938, 639.0892977507034, 3557.0929413000035, 3684.5394325709285, 3766.133789228438, 3795.8102094895144, 3829.7702137871815, 52833.0, 54035.0, 54401.455985439636, 54411.0, 54850.17724734132, 39596.60403395987, 47760.5223947763, 48365.516344836804, 49532.75233623881, 54199.45800541944, 47461.76269118701, 47463.0, 47682.5231747685, 48859.0, 49129.508704913205, 8161.143079976754, 8510.70212542558, 8550.0, 8734.344924130843, 8836.911630883866, 31147.0, 31675.366492670477, 31704.36591268208, 32324.83837580797, 33219.16952076121, 41712.3743143847, 41784.79107604443, 41940.790296048326, 41997.37003945004, 42077.0, 10986.835197472205, 11159.832602511131, 11167.329960202089, 11199.832002520132, 11206.047485963785, 11904.821427678766, 12425.633180349974, 12561.497540098293, 12640.55758048464, 12901.612951611467, 11028.558857645605, 11354.318740875575, 11600.477978491157, 11718.88281117212, 12320.75358492843, 11432.0, 11474.94262528682, 11575.189736718348, 11930.463129159381, 11940.04479641644, 11239.662810115382, 11380.089592832719, 11619.36093514831, 11622.70943226426, 11756.23584467007, 8955.865662014945, 9199.264058875407, 9312.805852515872, 9344.95327523358, 9510.38182518134, 8855.690050848189, 8987.865182022144, 9058.275337973078, 9191.034941331063, 9221.614281720538], "value": 6138.834224429328, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 110.0, 115.0, 116.0, 117.0, 110.0, 115.0, 119.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 161.0, 215.0, 133.0, 166.0, 153.0, 133.0, 184.0, 132.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 168.0, 168.0, 165.0, 163.0, 165.0, 166.0, 162.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 167.0, 76.0, 75.0, 75.0, 77.0, 164.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 175.0, 93.0, 94.0, 93.0, 152.0, 93.0, 94.0, 139.0], "value": 112.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 67.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 84.0, 88.0, 83.0, 82.0, 138.0, 86.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 129.0, 130.0, 136.0, 133.0, 134.0, 133.0, 147.0, 136.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 171.0, 181.0, 176.0, 168.0, 171.0, 177.0, 177.0, 170.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 71.0, 67.0, 65.0, 66.0, 65.0, 67.0, 66.0], "value": 67.3, "unit": "score"}]}]} 02:47:14 INFO - Return code: 0 02:47:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:47:14 ERROR - # TBPL SUCCESS # 02:47:14 INFO - Running post-action listener: _resource_record_post_action 02:47:14 INFO - ##### 02:47:14 INFO - ##### Finished run-tests step (success) 02:47:14 INFO - ##### 02:47:14 INFO - Running post-run listener: _resource_record_post_run 02:47:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533659648; Read time: 168; Write time: 441556 02:47:14 INFO - TinderboxPrint: CPU usage
13.5% 02:47:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 02:47:14 INFO - TinderboxPrint: I/O write bytes / time
533,659,648 / 441,556 02:47:14 INFO - TinderboxPrint: CPU idle
8,266.0 (86.5%) 02:47:14 INFO - TinderboxPrint: CPU user
1,232.0 (12.9%) 02:47:14 INFO - TinderboxPrint: Swap in / out
0 / 0 02:47:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242475008; Read time: 0; Write time: 250288 02:47:14 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291106816; Read time: 168; Write time: 191268 02:47:15 INFO - Running post-run listener: _upload_blobber_files 02:47:15 INFO - Blob upload gear active. 02:47:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:15 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 02:47:15 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:47:15 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:47:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:47:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:16 INFO - (blobuploader) - INFO - Done attempting. 02:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:21 INFO - (blobuploader) - INFO - Done attempting. 02:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:22 INFO - (blobuploader) - INFO - Done attempting. 02:47:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:22 INFO - Return code: 0 02:47:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7eb3135dbaba0a9acd41039c2243ad74e0cd208a3f842ad00b041775f54b48270520c440c41f2ebbf032b45cff9942ffe4f8bd2f99dc7cfec4dd17df2bbedb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16344930b5235a178bd6cd2173e37fef806912260ad5b6cfa73f766833d3df0be605fb16deab63cfa5f19c91acaa0474499603a4058c0aecb34094c642e3cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5189744d2d4f6f1420c4d2c9b4baa95c492fd945d046b28f12535b071573040082f82bc64522259ca93bc6f08a37f06b850ae3db7787783d2b227e6c5c572e73"} 02:47:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:22 INFO - Contents: 02:47:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7eb3135dbaba0a9acd41039c2243ad74e0cd208a3f842ad00b041775f54b48270520c440c41f2ebbf032b45cff9942ffe4f8bd2f99dc7cfec4dd17df2bbedb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16344930b5235a178bd6cd2173e37fef806912260ad5b6cfa73f766833d3df0be605fb16deab63cfa5f19c91acaa0474499603a4058c0aecb34094c642e3cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5189744d2d4f6f1420c4d2c9b4baa95c492fd945d046b28f12535b071573040082f82bc64522259ca93bc6f08a37f06b850ae3db7787783d2b227e6c5c572e73"} 02:47:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:22 INFO - Copying logs to upload dir... 02:47:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.589283 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 02:47:21.455524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:47:21.459146) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 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-Non-PGO/sha512/d7eb3135dbaba0a9acd41039c2243ad74e0cd208a3f842ad00b041775f54b48270520c440c41f2ebbf032b45cff9942ffe4f8bd2f99dc7cfec4dd17df2bbedb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16344930b5235a178bd6cd2173e37fef806912260ad5b6cfa73f766833d3df0be605fb16deab63cfa5f19c91acaa0474499603a4058c0aecb34094c642e3cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5189744d2d4f6f1420c4d2c9b4baa95c492fd945d046b28f12535b071573040082f82bc64522259ca93bc6f08a37f06b850ae3db7787783d2b227e6c5c572e73"} build_url:https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/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-Non-PGO/sha512/d7eb3135dbaba0a9acd41039c2243ad74e0cd208a3f842ad00b041775f54b48270520c440c41f2ebbf032b45cff9942ffe4f8bd2f99dc7cfec4dd17df2bbedb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16344930b5235a178bd6cd2173e37fef806912260ad5b6cfa73f766833d3df0be605fb16deab63cfa5f19c91acaa0474499603a4058c0aecb34094c642e3cd71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5189744d2d4f6f1420c4d2c9b4baa95c492fd945d046b28f12535b071573040082f82bc64522259ca93bc6f08a37f06b850ae3db7787783d2b227e6c5c572e73"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:47:21.485811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:47:21.486392) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463650001.870061-1504157147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:47:21.570496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:47:21.570815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:47:21.571099) ========= ========= Total master_lag: 0.15 =========