builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1463648718.42 results: success (0) buildid: 20160518225027 builduid: 2ee01dc602cf446ea5b6fc876154c117 revision: 7ab87e09f57b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.423811) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.424306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.424602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.437739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.438094) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 02:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-19 02:05:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.572625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.572940) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.623647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:18.624011) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ab87e09f57b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ab87e09f57b --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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 02:05:18,915 Setting DEBUG logging. 2016-05-19 02:05:18,915 attempt 1/10 2016-05-19 02:05:18,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7ab87e09f57b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 02:05:19,187 unpacking tar archive at: mozilla-inbound-7ab87e09f57b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:19.220005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:19.220343) ========= script_repo_revision: 7ab87e09f57b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:19.220745) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:19.221012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:05:19.229762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 02:05:19.230135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:19 INFO - MultiFileLogger online at 20160519 02:05:19 in /builds/slave/test 02:05:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:19 INFO - {'append_to_log': False, 02:05:19 INFO - 'base_work_dir': '/builds/slave/test', 02:05:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:19 INFO - 'branch': 'Mozilla-Inbound', 02:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:19 INFO - 'config_files': ('talos/linux_config.py',), 02:05:19 INFO - 'default_actions': ('clobber', 02:05:19 INFO - 'read-buildbot-config', 02:05:19 INFO - 'download-and-extract', 02:05:19 INFO - 'populate-webroot', 02:05:19 INFO - 'create-virtualenv', 02:05:19 INFO - 'install', 02:05:19 INFO - 'run-tests'), 02:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:19 INFO - 'download_minidump_stackwalk': True, 02:05:19 INFO - 'download_symbols': 'ondemand', 02:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:19 INFO - 'installer_path': 'installer.exe', 02:05:19 INFO - 'log_level': 'info', 02:05:19 INFO - 'log_name': 'talos', 02:05:19 INFO - 'log_to_console': True, 02:05:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:19 INFO - 'opt_config_files': (), 02:05:19 INFO - 'pip_index': False, 02:05:19 INFO - 'sps_profile': False, 02:05:19 INFO - 'sps_profile_interval': 0, 02:05:19 INFO - 'suite': 'dromaeojs-e10s', 02:05:19 INFO - 'system_bits': '32', 02:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:19 INFO - 'title': 'talos-linux64-ix-062', 02:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:19 INFO - 'use_talos_json': True, 02:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:19 INFO - 'work_dir': 'build'} 02:05:19 INFO - ##### 02:05:19 INFO - ##### Running clobber step. 02:05:19 INFO - ##### 02:05:19 INFO - Running pre-action listener: _resource_record_pre_action 02:05:19 INFO - Running main action method: clobber 02:05:19 INFO - rmtree: /builds/slave/test/build 02:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:20 INFO - Running post-action listener: _resource_record_post_action 02:05:20 INFO - ##### 02:05:20 INFO - ##### Finished clobber step (success) 02:05:20 INFO - ##### 02:05:20 INFO - ##### 02:05:20 INFO - ##### Running read-buildbot-config step. 02:05:20 INFO - ##### 02:05:20 INFO - Running pre-action listener: _resource_record_pre_action 02:05:20 INFO - Running main action method: read_buildbot_config 02:05:20 INFO - Using buildbot properties: 02:05:20 INFO - { 02:05:20 INFO - "project": "", 02:05:20 INFO - "product": "firefox", 02:05:20 INFO - "script_repo_revision": "production", 02:05:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:05:20 INFO - "repository": "", 02:05:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:05:20 INFO - "buildid": "20160518225027", 02:05:20 INFO - "pgo_build": "True", 02:05:20 INFO - "basedir": "/builds/slave/test", 02:05:20 INFO - "buildnumber": 698, 02:05:20 INFO - "slavename": "talos-linux64-ix-062", 02:05:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:05:20 INFO - "platform": "ubuntu64_hw", 02:05:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:05:20 INFO - "branch": "mozilla-inbound", 02:05:20 INFO - "repo_path": "integration/mozilla-inbound", 02:05:20 INFO - "revision": "7ab87e09f57b", 02:05:20 INFO - "stage_platform": "linux64-pgo", 02:05:20 INFO - "builduid": "2ee01dc602cf446ea5b6fc876154c117", 02:05:20 INFO - "slavebuilddir": "test" 02:05:20 INFO - } 02:05:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:05:20 INFO - Running post-action listener: _resource_record_post_action 02:05:20 INFO - ##### 02:05:20 INFO - ##### Finished read-buildbot-config step (success) 02:05:20 INFO - ##### 02:05:20 INFO - ##### 02:05:20 INFO - ##### Running download-and-extract step. 02:05:20 INFO - ##### 02:05:20 INFO - Running pre-action listener: _resource_record_pre_action 02:05:20 INFO - Running main action method: download_and_extract 02:05:20 INFO - mkdir: /builds/slave/test/build/tests 02:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:20 INFO - https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:20 INFO - Downloaded 1361 bytes. 02:05:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:05:20 INFO - Using the following test package requirements: 02:05:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:05:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'jsshell-linux-x86_64.zip'], 02:05:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:05:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:05:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:20 INFO - https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:22 INFO - Downloaded 24386625 bytes. 02:05:22 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:05:22 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:05:23 INFO - Return code: 0 02:05:23 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:05:23 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:05:23 INFO - https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:24 INFO - Downloaded 24386625 bytes. 02:05:24 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:05:24 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:05:25 INFO - Return code: 0 02:05:25 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:05:25 INFO - https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:26 INFO - Downloaded 10840359 bytes. 02:05:26 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:05:26 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:05:27 INFO - Return code: 0 02:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:27 INFO - https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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:05:30 INFO - Downloaded 58584572 bytes. 02:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:05:30 INFO - mkdir: /builds/slave/test/properties 02:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:30 INFO - Contents: 02:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:05:31 INFO - Running post-action listener: _resource_record_post_action 02:05:31 INFO - Running post-action listener: set_extra_try_arguments 02:05:31 INFO - ##### 02:05:31 INFO - ##### Finished download-and-extract step (success) 02:05:31 INFO - ##### 02:05:31 INFO - ##### 02:05:31 INFO - ##### Running populate-webroot step. 02:05:31 INFO - ##### 02:05:31 INFO - Running pre-action listener: _resource_record_pre_action 02:05:31 INFO - Running main action method: populate_webroot 02:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:31 INFO - '--tppagecycles', 02:05:31 INFO - '7'], 02:05:31 INFO - 'tests': ['tsvgm']}}, 02:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['damp', 'tps']}, 02:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'tests': ['damp', 'tps']}, 02:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['dromaeo_dom']}, 02:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tsvgx', 02:05:31 INFO - 'tsvgr_opacity', 02:05:31 INFO - 'tart', 02:05:31 INFO - 'tscrollx', 02:05:31 INFO - 'cart']}, 02:05:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:31 INFO - 'tsvgr_opacity', 02:05:31 INFO - 'tart', 02:05:31 INFO - 'tscrollx', 02:05:31 INFO - 'cart']}, 02:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tp5o']}, 02:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'tests': ['tp5o']}, 02:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s', 02:05:31 INFO - '--xperf_path', 02:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:31 INFO - 'tests': ['tp5n']}, 02:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:31 INFO - 'talos_options': ['--xperf_path', 02:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:31 INFO - 'tests': ['tp5n']}}, 02:05:31 INFO - 'talos.zip': {'path': '', 02:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:31 INFO - Running post-action listener: _resource_record_post_action 02:05:31 INFO - ##### 02:05:31 INFO - ##### Finished populate-webroot step (success) 02:05:31 INFO - ##### 02:05:31 INFO - ##### 02:05:31 INFO - ##### Running create-virtualenv step. 02:05:31 INFO - ##### 02:05:31 INFO - Running pre-action listener: _resource_record_pre_action 02:05:31 INFO - Running main action method: create_virtualenv 02:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:31 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:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:31 INFO - Using real prefix '/usr' 02:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:34 INFO - Installing pip.................done. 02:05:34 INFO - Return code: 0 02:05:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:34 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:34 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:05:34 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:05:34 INFO - Using env: {'DISPLAY': ':0', 02:05:34 INFO - 'HOME': '/home/cltbld', 02:05:34 INFO - 'LANG': 'en_US.UTF-8', 02:05:34 INFO - 'LANGUAGE': 'en_US:en', 02:05:34 INFO - 'LOGNAME': 'cltbld', 02:05:34 INFO - 'MAIL': '/var/mail/cltbld', 02:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:34 INFO - 'MOZ_NO_REMOTE': '1', 02:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:34 INFO - 'NO_EM_RESTART': '1', 02:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:34 INFO - 'PWD': '/builds/slave/test', 02:05:34 INFO - 'SHELL': '/bin/bash', 02:05:34 INFO - 'SHLVL': '1', 02:05:34 INFO - 'TERM': 'linux', 02:05:34 INFO - 'TMOUT': '86400', 02:05:34 INFO - 'USER': 'cltbld', 02:05:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:34 INFO - '_': '/tools/buildbot/bin/python'} 02:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:34 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:05:34 INFO - Cleaning up... 02:05:34 INFO - Return code: 0 02:05:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:34 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:34 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:05:34 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:05:34 INFO - Using env: {'DISPLAY': ':0', 02:05:34 INFO - 'HOME': '/home/cltbld', 02:05:34 INFO - 'LANG': 'en_US.UTF-8', 02:05:34 INFO - 'LANGUAGE': 'en_US:en', 02:05:34 INFO - 'LOGNAME': 'cltbld', 02:05:34 INFO - 'MAIL': '/var/mail/cltbld', 02:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:34 INFO - 'MOZ_NO_REMOTE': '1', 02:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:34 INFO - 'NO_EM_RESTART': '1', 02:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:34 INFO - 'PWD': '/builds/slave/test', 02:05:34 INFO - 'SHELL': '/bin/bash', 02:05:34 INFO - 'SHLVL': '1', 02:05:34 INFO - 'TERM': 'linux', 02:05:34 INFO - 'TMOUT': '86400', 02:05:34 INFO - 'USER': 'cltbld', 02:05:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:34 INFO - '_': '/tools/buildbot/bin/python'} 02:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:34 INFO - Downloading/unpacking psutil>=3.1.1 02:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:36 INFO - Installing collected packages: psutil 02:05:36 INFO - Running setup.py install for psutil 02:05:37 INFO - building 'psutil._psutil_linux' extension 02:05:37 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:05:37 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:05:37 INFO - building 'psutil._psutil_posix' extension 02:05:37 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:05:37 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:05:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:37 INFO - Successfully installed psutil 02:05:37 INFO - Cleaning up... 02:05:37 INFO - Return code: 0 02:05:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:05:37 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:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:37 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:05:37 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:05:37 INFO - Using env: {'DISPLAY': ':0', 02:05:37 INFO - 'HOME': '/home/cltbld', 02:05:37 INFO - 'LANG': 'en_US.UTF-8', 02:05:37 INFO - 'LANGUAGE': 'en_US:en', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MAIL': '/var/mail/cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SHLVL': '1', 02:05:37 INFO - 'TERM': 'linux', 02:05:37 INFO - 'TMOUT': '86400', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - '_': '/tools/buildbot/bin/python'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:05:39 INFO - Installing collected packages: mozsystemmonitor 02:05:39 INFO - Running setup.py install for mozsystemmonitor 02:05:39 INFO - Successfully installed mozsystemmonitor 02:05:39 INFO - Cleaning up... 02:05:39 INFO - Return code: 0 02:05:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:39 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:39 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:05:39 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:05:39 INFO - Using env: {'DISPLAY': ':0', 02:05:39 INFO - 'HOME': '/home/cltbld', 02:05:39 INFO - 'LANG': 'en_US.UTF-8', 02:05:39 INFO - 'LANGUAGE': 'en_US:en', 02:05:39 INFO - 'LOGNAME': 'cltbld', 02:05:39 INFO - 'MAIL': '/var/mail/cltbld', 02:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:39 INFO - 'MOZ_NO_REMOTE': '1', 02:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:39 INFO - 'NO_EM_RESTART': '1', 02:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:39 INFO - 'PWD': '/builds/slave/test', 02:05:39 INFO - 'SHELL': '/bin/bash', 02:05:39 INFO - 'SHLVL': '1', 02:05:39 INFO - 'TERM': 'linux', 02:05:39 INFO - 'TMOUT': '86400', 02:05:39 INFO - 'USER': 'cltbld', 02:05:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:39 INFO - '_': '/tools/buildbot/bin/python'} 02:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:05:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:05:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:42 INFO - Downloading docopt-0.6.1.tar.gz 02:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:05:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:05:42 INFO - Running setup.py install for blobuploader 02:05:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:05:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:05:42 INFO - Running setup.py install for requests 02:05:43 INFO - Running setup.py install for docopt 02:05:43 INFO - Successfully installed blobuploader requests docopt 02:05:43 INFO - Cleaning up... 02:05:43 INFO - Return code: 0 02:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:43 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:43 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:05:43 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:05:43 INFO - Using env: {'DISPLAY': ':0', 02:05:43 INFO - 'HOME': '/home/cltbld', 02:05:43 INFO - 'LANG': 'en_US.UTF-8', 02:05:43 INFO - 'LANGUAGE': 'en_US:en', 02:05:43 INFO - 'LOGNAME': 'cltbld', 02:05:43 INFO - 'MAIL': '/var/mail/cltbld', 02:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:43 INFO - 'MOZ_NO_REMOTE': '1', 02:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:43 INFO - 'NO_EM_RESTART': '1', 02:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:43 INFO - 'PWD': '/builds/slave/test', 02:05:43 INFO - 'SHELL': '/bin/bash', 02:05:43 INFO - 'SHLVL': '1', 02:05:43 INFO - 'TERM': 'linux', 02:05:43 INFO - 'TMOUT': '86400', 02:05:43 INFO - 'USER': 'cltbld', 02:05:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:43 INFO - '_': '/tools/buildbot/bin/python'} 02:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:05:43 INFO - Running setup.py (path:/tmp/pip-yxTtX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:05:43 INFO - Running setup.py (path:/tmp/pip-9sEJro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:05:43 INFO - Running setup.py (path:/tmp/pip-hEqeCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:05:43 INFO - Running setup.py (path:/tmp/pip-jZHT3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:05:43 INFO - Running setup.py (path:/tmp/pip-OGHu7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:05:43 INFO - Running setup.py (path:/tmp/pip-IhTd93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:05:43 INFO - Running setup.py (path:/tmp/pip-qailFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:05:44 INFO - Running setup.py (path:/tmp/pip-cOlvxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:05:44 INFO - Running setup.py (path:/tmp/pip-kf7axU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:05:44 INFO - Running setup.py (path:/tmp/pip-_81kgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:05:44 INFO - Running setup.py (path:/tmp/pip-Vj10k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:05:44 INFO - Running setup.py (path:/tmp/pip-7ZDHHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:05:44 INFO - Running setup.py (path:/tmp/pip-zFBxuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:05:44 INFO - Running setup.py (path:/tmp/pip-bC4AzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:44 INFO - Running setup.py (path:/tmp/pip-3vghC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:05:44 INFO - Running setup.py (path:/tmp/pip-Ot23jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:05:44 INFO - Running setup.py (path:/tmp/pip-VoS7QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:05:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:05:44 INFO - Running setup.py install for manifestparser 02:05:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:05:44 INFO - Running setup.py install for mozcrash 02:05:44 INFO - Running setup.py install for mozdebug 02:05:45 INFO - Running setup.py install for mozdevice 02:05:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for mozfile 02:05:45 INFO - Running setup.py install for mozhttpd 02:05:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for mozinfo 02:05:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for mozInstall 02:05:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for mozleak 02:05:45 INFO - Running setup.py install for mozlog 02:05:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for moznetwork 02:05:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:05:45 INFO - Running setup.py install for mozprocess 02:05:46 INFO - Running setup.py install for mozprofile 02:05:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:05:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:05:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:05:46 INFO - Running setup.py install for mozrunner 02:05:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:05:46 INFO - Running setup.py install for mozscreenshot 02:05:46 INFO - Running setup.py install for moztest 02:05:46 INFO - Running setup.py install for mozversion 02:05:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:05:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:05:46 INFO - Cleaning up... 02:05:46 INFO - Return code: 0 02:05:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:46 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:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:46 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:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:46 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:46 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:05:46 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:05:46 INFO - Using env: {'DISPLAY': ':0', 02:05:46 INFO - 'HOME': '/home/cltbld', 02:05:46 INFO - 'LANG': 'en_US.UTF-8', 02:05:46 INFO - 'LANGUAGE': 'en_US:en', 02:05:46 INFO - 'LOGNAME': 'cltbld', 02:05:46 INFO - 'MAIL': '/var/mail/cltbld', 02:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:46 INFO - 'MOZ_NO_REMOTE': '1', 02:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:46 INFO - 'NO_EM_RESTART': '1', 02:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:46 INFO - 'PWD': '/builds/slave/test', 02:05:46 INFO - 'SHELL': '/bin/bash', 02:05:46 INFO - 'SHLVL': '1', 02:05:46 INFO - 'TERM': 'linux', 02:05:46 INFO - 'TMOUT': '86400', 02:05:46 INFO - 'USER': 'cltbld', 02:05:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:46 INFO - '_': '/tools/buildbot/bin/python'} 02:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:05:46 INFO - Running setup.py (path:/tmp/pip-8_dpbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:05:46 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:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:05:46 INFO - Running setup.py (path:/tmp/pip-xy_WGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:05:46 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:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:05:46 INFO - Running setup.py (path:/tmp/pip-Elpw35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:05:47 INFO - Running setup.py (path:/tmp/pip-TlWl02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:05:47 INFO - Running setup.py (path:/tmp/pip-XeDiiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:05:47 INFO - Running setup.py (path:/tmp/pip-Tp_uZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:05:47 INFO - Running setup.py (path:/tmp/pip-SyqeVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:05:47 INFO - Running setup.py (path:/tmp/pip-wT0R9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:05:47 INFO - Running setup.py (path:/tmp/pip-P2LKTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:05:47 INFO - Running setup.py (path:/tmp/pip-a6ExPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:05:47 INFO - Running setup.py (path:/tmp/pip-voTZBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:05:47 INFO - Running setup.py (path:/tmp/pip-haPrRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:05:47 INFO - Running setup.py (path:/tmp/pip-ktrHJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:05:47 INFO - Running setup.py (path:/tmp/pip-qdwfhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:47 INFO - Running setup.py (path:/tmp/pip-gh95AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:05:47 INFO - Running setup.py (path:/tmp/pip-ONgb4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:05:47 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:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:05:47 INFO - Running setup.py (path:/tmp/pip-INsCjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:05:48 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:05:48 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:05:48 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:05:48 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:05:48 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:05:48 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:05:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:05:48 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:05:48 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:05:48 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:05:48 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:05:48 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:05:48 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:05:49 INFO - Downloading blessings-1.6.tar.gz 02:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:05:50 INFO - Installing collected packages: blessings 02:05:50 INFO - Running setup.py install for blessings 02:05:50 INFO - Successfully installed blessings 02:05:50 INFO - Cleaning up... 02:05:50 INFO - Return code: 0 02:05:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:05:50 INFO - Reading from file tmpfile_stdout 02:05:50 INFO - Current package versions: 02:05:50 INFO - argparse == 1.2.1 02:05:50 INFO - blessings == 1.6 02:05:50 INFO - blobuploader == 1.2.4 02:05:50 INFO - docopt == 0.6.1 02:05:50 INFO - manifestparser == 1.1 02:05:50 INFO - mozInstall == 1.12 02:05:50 INFO - mozcrash == 0.17 02:05:50 INFO - mozdebug == 0.1 02:05:50 INFO - mozdevice == 0.48 02:05:50 INFO - mozfile == 1.2 02:05:50 INFO - mozhttpd == 0.7 02:05:50 INFO - mozinfo == 0.9 02:05:50 INFO - mozleak == 0.1 02:05:50 INFO - mozlog == 3.2 02:05:50 INFO - moznetwork == 0.27 02:05:50 INFO - mozprocess == 0.22 02:05:50 INFO - mozprofile == 0.28 02:05:50 INFO - mozrunner == 6.11 02:05:50 INFO - mozscreenshot == 0.1 02:05:50 INFO - mozsystemmonitor == 0.3 02:05:50 INFO - moztest == 0.7 02:05:50 INFO - mozversion == 1.4 02:05:50 INFO - psutil == 3.1.1 02:05:50 INFO - requests == 1.2.3 02:05:50 INFO - wsgiref == 0.1.2 02:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:50 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:05:50 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:05:50 INFO - Using env: {'DISPLAY': ':0', 02:05:50 INFO - 'HOME': '/home/cltbld', 02:05:50 INFO - 'LANG': 'en_US.UTF-8', 02:05:50 INFO - 'LANGUAGE': 'en_US:en', 02:05:50 INFO - 'LOGNAME': 'cltbld', 02:05:50 INFO - 'MAIL': '/var/mail/cltbld', 02:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:50 INFO - 'MOZ_NO_REMOTE': '1', 02:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:50 INFO - 'NO_EM_RESTART': '1', 02:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:50 INFO - 'PWD': '/builds/slave/test', 02:05:50 INFO - 'SHELL': '/bin/bash', 02:05:50 INFO - 'SHLVL': '1', 02:05:50 INFO - 'TERM': 'linux', 02:05:50 INFO - 'TMOUT': '86400', 02:05:50 INFO - 'USER': 'cltbld', 02:05:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:50 INFO - '_': '/tools/buildbot/bin/python'} 02:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 INFO - Cleaning up... 02:05:50 INFO - Return code: 0 02:05:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:05:50 INFO - Using env: {'DISPLAY': ':0', 02:05:50 INFO - 'HOME': '/home/cltbld', 02:05:50 INFO - 'LANG': 'en_US.UTF-8', 02:05:50 INFO - 'LANGUAGE': 'en_US:en', 02:05:50 INFO - 'LOGNAME': 'cltbld', 02:05:50 INFO - 'MAIL': '/var/mail/cltbld', 02:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:50 INFO - 'MOZ_NO_REMOTE': '1', 02:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:50 INFO - 'NO_EM_RESTART': '1', 02:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:50 INFO - 'PWD': '/builds/slave/test', 02:05:50 INFO - 'SHELL': '/bin/bash', 02:05:50 INFO - 'SHLVL': '1', 02:05:50 INFO - 'TERM': 'linux', 02:05:50 INFO - 'TMOUT': '86400', 02:05:50 INFO - 'USER': 'cltbld', 02:05:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:50 INFO - '_': '/tools/buildbot/bin/python'} 02:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:50 INFO - Downloading/unpacking jsonschema 02:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:05:52 INFO - Downloading/unpacking functools32 (from jsonschema) 02:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:05:52 INFO - warning: no files found matching '*.txt' 02:05:52 INFO - no previously-included directories found matching 'build' 02:05:52 INFO - no previously-included directories found matching 'dist' 02:05:52 INFO - no previously-included directories found matching '.git*' 02:05:52 INFO - Installing collected packages: jsonschema, functools32 02:05:53 INFO - Running setup.py install for functools32 02:05:53 INFO - warning: no files found matching '*.txt' 02:05:53 INFO - no previously-included directories found matching 'build' 02:05:53 INFO - no previously-included directories found matching 'dist' 02:05:53 INFO - no previously-included directories found matching '.git*' 02:05:53 INFO - Successfully installed jsonschema functools32 02:05:53 INFO - Cleaning up... 02:05:53 INFO - Return code: 0 02:05:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:05:53 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:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:53 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:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:53 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 0x7f1b3a70af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', '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:05:53 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:05:53 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:05:53 INFO - Using env: {'DISPLAY': ':0', 02:05:53 INFO - 'HOME': '/home/cltbld', 02:05:53 INFO - 'LANG': 'en_US.UTF-8', 02:05:53 INFO - 'LANGUAGE': 'en_US:en', 02:05:53 INFO - 'LOGNAME': 'cltbld', 02:05:53 INFO - 'MAIL': '/var/mail/cltbld', 02:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:53 INFO - 'MOZ_NO_REMOTE': '1', 02:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:53 INFO - 'NO_EM_RESTART': '1', 02:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:53 INFO - 'PWD': '/builds/slave/test', 02:05:53 INFO - 'SHELL': '/bin/bash', 02:05:53 INFO - 'SHLVL': '1', 02:05:53 INFO - 'TERM': 'linux', 02:05:53 INFO - 'TMOUT': '86400', 02:05:53 INFO - 'USER': 'cltbld', 02:05:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:53 INFO - '_': '/tools/buildbot/bin/python'} 02:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:53 INFO - Downloading/unpacking flake8 02:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:05:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:05:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:05:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:05:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:05:56 INFO - no previously-included directories found matching 'docs/_build' 02:05:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:05:56 INFO - Running setup.py install for pep8 02:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:05:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:05:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:05:56 INFO - no previously-included directories found matching 'docs/_build' 02:05:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:05:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:05:56 INFO - Cleaning up... 02:05:56 INFO - Return code: 0 02:05:56 INFO - Running post-action listener: _resource_record_post_action 02:05:56 INFO - Running post-action listener: _start_resource_monitoring 02:05:56 INFO - Starting resource monitoring. 02:05:56 INFO - ##### 02:05:56 INFO - ##### Finished create-virtualenv step (success) 02:05:56 INFO - ##### 02:05:56 INFO - ##### 02:05:56 INFO - ##### Running install step. 02:05:56 INFO - ##### 02:05:56 INFO - Running pre-action listener: _resource_record_pre_action 02:05:56 INFO - Running main action method: install 02:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:05:56 INFO - Reading from file tmpfile_stdout 02:05:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:05:56 INFO - Reading from file tmpfile_stdout 02:05:56 INFO - Output received: 02:05:56 INFO - Usage: mozinstall [options] installer 02:05:56 INFO - Options: 02:05:56 INFO - -h, --help show this help message and exit 02:05:56 INFO - -d DEST, --destination=DEST 02:05:56 INFO - Directory to install application into. [default: 02:05:56 INFO - "/builds/slave/test"] 02:05:56 INFO - --app=APP Application being installed. [default: firefox] 02:05:56 INFO - mkdir: /builds/slave/test/build/application 02:05:56 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:05:56 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:06:13 INFO - Reading from file tmpfile_stdout 02:06:13 INFO - Output received: 02:06:13 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:13 INFO - Running post-action listener: _resource_record_post_action 02:06:13 INFO - ##### 02:06:13 INFO - ##### Finished install step (success) 02:06:13 INFO - ##### 02:06:13 INFO - ##### 02:06:13 INFO - ##### Running run-tests step. 02:06:13 INFO - ##### 02:06:13 INFO - Running pre-action listener: _resource_record_pre_action 02:06:13 INFO - Running main action method: run_tests 02:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:13 INFO - Python 2.7.3 02:06:13 INFO - Return code: 0 02:06:13 INFO - grabbing minidump binary from tooltool 02:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:13 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 0x2b099c0>, '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 0x2b0a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:13 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:06:13 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:06:13 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:06:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:13 INFO - Return code: 0 02:06:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:06:14 INFO - Return code: 0 02:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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:06:14 INFO - Using env: {'DISPLAY': ':0', 02:06:14 INFO - 'HOME': '/home/cltbld', 02:06:14 INFO - 'LANG': 'en_US.UTF-8', 02:06:14 INFO - 'LANGUAGE': 'en_US:en', 02:06:14 INFO - 'LOGNAME': 'cltbld', 02:06:14 INFO - 'MAIL': '/var/mail/cltbld', 02:06:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:14 INFO - 'MOZ_NO_REMOTE': '1', 02:06:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:14 INFO - 'NO_EM_RESTART': '1', 02:06:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:14 INFO - 'PWD': '/builds/slave/test', 02:06:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:14 INFO - 'SHELL': '/bin/bash', 02:06:14 INFO - 'SHLVL': '1', 02:06:14 INFO - 'TERM': 'linux', 02:06:14 INFO - 'TMOUT': '86400', 02:06:14 INFO - 'USER': 'cltbld', 02:06:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084', 02:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:14 INFO - '_': '/tools/buildbot/bin/python'} 02:06:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:06:14 INFO - mozversion application_buildid: 20160518225027 02:06:14 INFO - mozversion application_changeset: 7ab87e09f57b97da66c986b70f539b0289aba3cf 02:06:14 INFO - mozversion application_display_name: Nightly 02:06:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:14 INFO - mozversion application_name: Firefox 02:06:14 INFO - mozversion application_remotingname: firefox 02:06:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:06:14 INFO - mozversion application_vendor: Mozilla 02:06:14 INFO - mozversion application_version: 49.0a1 02:06:14 INFO - mozversion platform_buildid: 20160518225027 02:06:14 INFO - mozversion platform_changeset: 7ab87e09f57b97da66c986b70f539b0289aba3cf 02:06:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:06:14 INFO - mozversion platform_version: 49.0a1 02:06:14 INFO - using testdate: 1463648774 02:06:14 INFO - actual date: 1463648774 02:06:14 INFO - starting webserver on 'localhost:41029' 02:06:14 INFO - SUITE-START | Running 2 tests 02:06:14 INFO - TEST-START | dromaeo_css 02:06:14 INFO - operating with platform_type : linux_ 02:06:14 INFO - Initialising browser for dromaeo_css test... 02:06:14 INFO - TEST-INFO | started process 21893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNUbc3/profile http://localhost:41029/getInfo.html) 02:06:18 INFO - PROCESS | 21893 | 02:06:18 INFO - PROCESS | 21893 | (process:21963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:06:19 INFO - PROCESS | 21893 | __metrics Screen width/height:1600/1200 02:06:19 INFO - PROCESS | 21893 | colorDepth:24 02:06:19 INFO - PROCESS | 21893 | Browser inner width/height: 1024/697 02:06:19 INFO - PROCESS | 21893 | __metrics 02:06:19 ERROR - PROCESS | 21893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:06:20 INFO - TEST-INFO | 21893: exit 0 02:06:20 INFO - Browser initialized. 02:06:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:20 INFO - TEST-INFO | started process 22014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNUbc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:22 INFO - PROCESS | 22014 | 02:06:22 INFO - PROCESS | 22014 | (process:22076): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:06:32 INFO - PROCESS | 22014 | RSS: Main: 164118528 02:06:32 INFO - PROCESS | 22014 | 02:07:22 INFO - PROCESS | 22014 | 1463648842033 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:09:28 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41029/tests/dromaeo/cssquery-ext.html) 02:09:29 INFO - PROCESS | 22014 | RSS: Main: 167313408 02:09:29 INFO - PROCESS | 22014 | 02:12:31 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-ext.html (next: http://localhost:41029/tests/dromaeo/cssquery-jquery.html) 02:12:32 INFO - PROCESS | 22014 | RSS: Main: 167018496 02:12:32 INFO - PROCESS | 22014 | 02:15:34 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41029/tests/dromaeo/cssquery-mootools.html) 02:15:34 INFO - PROCESS | 22014 | RSS: Main: 168304640 02:15:34 INFO - PROCESS | 22014 | 02:18:36 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41029/tests/dromaeo/cssquery-prototype.html) 02:18:37 INFO - PROCESS | 22014 | RSS: Main: 165699584 02:18:37 INFO - PROCESS | 22014 | 02:21:39 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41029/tests/dromaeo/cssquery-yui.html) 02:21:40 INFO - PROCESS | 22014 | RSS: Main: 166797312 02:21:40 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | Cycle 1(1): loaded http://localhost:41029/tests/dromaeo/cssquery-yui.html (next: http://localhost:41029/tests/dromaeo/cssquery-dojo.html) 02:24:42 INFO - PROCESS | 22014 | RSS: Main: 169242624 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | __start_tp_report 02:24:42 INFO - PROCESS | 22014 | _x_x_mozilla_page_load 02:24:42 INFO - PROCESS | 22014 | _x_x_mozilla_page_load_details 02:24:42 INFO - PROCESS | 22014 | |i|pagename|runs| 02:24:42 INFO - PROCESS | 22014 | |0;dojo.html;3121.0636808957306;3135.7961732487393;3136.404083224187;3144.716975472207;3173.3177366866134;5199.896002079956;5290.735463226838;5300.231466437364;5405.297311349529;5428.972855135728;5400;5411.891762164754;5412.269343638608;5487.945120548793;5583.553315734742;4869.196582563882;4885.902281954359;4895.828645997391;4926.77886621495;4969.850904472872;66.62079819862021;4905.239687848371;4948.50514948504;4968.229924361712;5015.974920125413;4907.460179380265;4915.3364295819965;4921.212605983043;4927.482614325516;4944.505549445063;4873.853784386474;4894.388201474816;4912.707876997684;4921.114199444099;4926.0394223126505;4715.104130215248;4822.903541929142;4827.879303017417;4847.079054979577;4910.90178196434;5179.689218646893;5210.4268530461995;5210.76551555181;5314.468553144693;5333.679979201261;5784.2769653793275;5786.255270678045;5801.767929282823;5822.243108395882;5853.034249348852;5741.9951508486265;5767.711614419262;5768.596198266123;5813.157092221604;5841.707914604295;5371.785128594852;5402.594805389612;5409.891802163974;5410;5414.052540805383;5853.970730146322;5945.910811337833;5949.732262048175;5950.315713692894;5953.374895635896;5697.772089116389;5755.424457554295;5780.421957804186;5806.274215723035;5834.358220595731;5861.120831875252;5862.325832529314;5864.8533786654825;5870.148828419855;5883.764649414061;5681.375048744635;5743.569232307594;5755.194272801811;5838.153467747238;5853.414658534112;5515.420880807537;5778.739956701958;5790.971045144747;5839.532837373;5876.118582212703;4426.22541055314;4429.313456414261;4453.844115455943;4469.106178764195;4527.660425468103;3858.1897801462005;3950.190211006794;3957.426173204869;3978.403239514096;4016;5620.578456615688;5623.971880140573;5681.57388195887;5706;5711.543076553866;5787.102999035156;5811.418858114154;5868.09044598088;5898.469137777534;5958.821235362946;5408.215808707794;5569.164625306236;5587.497125258747;5609.074502707008;5611.102223644198;4975.228839529878;5014.172661510883;5030.4718004608985;5049.166887463527;5050.191969284897;5991.101334799815;6034.577579569388;6049.243844519435;6063.6664983426335;6086.756529738761;5536.806211782568;5800.622959507618;5800.912986305293;5851.561132914963;5878.735456904364;6102.9694851525455;6107.9083813741945;6121.969390153021;6123.510119190543;6127.29536103336;5634.85912852182;5774.364819869895;5777.2200752897825;5777.91333129995;5788.957987562279;5866.50134738552;5885.117232415172;5910.468057874812;5912.438318359921;5933.465988060922;5713.771449142154;5736.71316434185;5799.594028417971;5803.419658034163;5805.593608447537;5536.058869992031;5570.136628822539;5730.398308177581;5740.913886291625;5764.884702306014;5506.03644362243;5518.117101263779;5533.280673512418;5534.91697624544;5597.63615365;5609.971950140223;5700.572457065819;5774.220480235114;5774.422557744192;5781.971090144522;5437;5591.217229587943;5610.270664813548;5613.915791263216;5649.37856835756 02:24:42 INFO - PROCESS | 22014 | |1;ext.html;586.114966400735;604.6100265328862;623.2925629410619;629.9118123462713;630.4987534909743;32498.67501324989;43321.78339108304;43992.780036099815;44041.559584404225;47331.290030649565;45552.544474555245;45696.543034569644;45699.31451028237;45929.77035114828;46093.30860037102;8737.257333126676;8795.428297160695;8829.381943263974;8863.77840553988;8881.511516866569;8638.395312328108;8873.600687969058;8885.733427997171;8885.822283554326;8923;8898.466092034467;8915.420497667663;8926.910730892705;8966.910330896673;8970.686025989091;8847.33644976626;8918.019017908058;8953.23897468716;8965.910340896606;8970.372073954826;8648.567571621394;8737.126287371275;8742.606582703793;8750.03749587545;8754.212120909086;42336.36495452571;42944.355834662194;43219.783901080606;43293.35059974103;43582.34626480605;3544.362014837354;3590.4075827488696;3684.907877303062;3826.770393776382;3984.2429938311916;32074.518882216784;32588.34823303544;33034;33147.33705325904;33616;4053.2298863215897;4100.876973690794;4147.751134931914;4152.6055024772595;4228.04868904494;341256;344196;345145;345349;348829;34758.47862282068;56033.43966560364;56659;56810.431895681344;56870;35569.110772230386;36891.63108368882;37108.814455928084;37140.62859371426;37303.81348093242;15276.847231527765;15323.46367877119;15397.23013849303;15405.614859628598;15492.457763978207;12393.822586854234;12496.437660305308;12586.81119783204;12587.874121258854;12645.93677031609;8381;8400.621972011275;8407.957960210282;8447.788805279917;8497.830043399097;3246.188452886778;3298.3238436120537;3309.5532103165765;3312.254742682877;3326.86692532296;1000.6697789729371;1001.6644424117857;1053.8840727519967;1069.3263244156133;1129.7119234595125;30229;30232.244193894887;30736.53895191574;30919.381612368077;31293.217669557987;1097.6322931817772;1097.8956999085074;1104.6023431564631;1146.5241924601364;1158.9014933730728;16132.75800862988;16163.43427980015;16288.022718636683;16550.006999580062;16756;524624;524767;530031;530402;535713;58114.709426453446;58121;58233.12650310249;58442.70778646079;58583.707081465174;1377.579838149354;1387.4103506009906;1400.2368709053387;1405.0796728143082;1409.2812665540648;30341.241468963453;30633.540496892118;31083.067507974796;31325.686743132275;31495;50425;50584.747076264386;50622;50640.493595065054;50742.492575073775;424723;426977;428913;429925;431401;26107.08625198109;28034.2991425216;28890.27774305659;29098.127056188347;30333;48190.759046205945;48706;48910.3681929143;49643;49673.25490117579;39633;40389.79805100956;40627.59372406238;40862.59137408588;42302.153956921306;40829;40884.182316354105;41346.379804302356;42448.36327455029;42861.571384287;41273;41302.586974129874;41897.79051104725;42306.57693423027;44806;35288.47067293942;36403.07572629618;38632.80683596564;38857.41713874238;39069;26987.460250795266;27186.32034199161;27560.310992225353;27814.84009506104;27816.86091569529 02:24:42 INFO - PROCESS | 22014 | |2;jquery.html;397.8309218582103;403.1030956122627;406.906411525349;408.399652510809;417.8706379195376;13776.793348099787;19002.714959275603;19116.522086947833;19777.703334449994;19848.702269465968;18443.262269509236;18784.71822922654;19023.904880475613;19027.572932030085;19243.134058967345;5373.462653734625;5435.1847222916485;5582.888342233153;5674.659520428767;5699.629524080921;5588.497035266825;5597.216389705444;5612.438756124396;5614.410486898878;5632.718364081779;5402.810901618444;5585.916211256814;5593.161025846115;5598.664080155183;5603.159526071081;5548.77804887804;5551.472610102034;5554.222408862783;5555.000099982001;5580.776768929238;4781.832635857763;4974.900501989976;4991.475895031006;5007.4491805901325;5023.673461225045;22182.88908555463;22712.545749084926;22821.543569128524;22872;22922.19772307961;2416.32342943976;2418.4921166555046;2422.2127808462146;2517.408409023878;2693.892244310225;13890.93054534731;14281.428742850274;14313.78529322061;14657.56027319182;14703.264836758119;1895.3840001999406;2002.839772818171;2069.14130635786;2074.8962551872346;2075.190675636503;81404.7086939347;81530;81670.59164704138;82371.7644235331;82685.58657206675;10340.948295258475;10385.324953877975;10632.362058276529;10685.358878467317;10764.246502744732;14715.484958026631;14750;14833.258337083103;14966.70066598662;14988.925055374653;7924.524528528192;8193.385496087818;8280.089190189074;8314.168583141638;8344;7801.531908085533;7848.489848159851;7868.763937081897;8034.397420193509;8084.595770211466;6448.678475748727;6472.126262954535;6474.805755827333;6538.313477084933;6808.9659551701925;1947.7078438234378;1952.3166891588114;1952.8437724981968;1958.1873522488008;1979.8911059891843;934.6121359635675;1036.186593524095;1057.9894201058046;1061.4268295120703;1092.7377429416883;18209.362672306404;18269;18646.160922758238;18805.529861753294;18930.01234870346;1013.5135135135176;1022.7397451631828;1034.446571084466;1037.901399367059;1051.348164138239;10740.409277489813;10916.12670986335;11083.889161108285;11109.44452777358;11173.441327933571;423672;425715;425860;427778;428234;83322.58338708268;89481;90355;90762.54618726997;92936.53531732298;1030.9381437113798;1044.8171569975225;1082.2694681090234;1088.6081010836092;1089.629525961177;16883.32466701318;16919.66160676755;16994.745078824075;17074.829251707823;17407.91296043512;41485;41745.58254417417;43200.35199472073;43544;44683.77658111689;58976;59361;59973;60663;61108.69445652743;8578.871316930376;8687.652493900174;8688.39181257306;8780.956095219482;8840.823183536164;9741;12793.976481881242;13267.137636053625;13368.732625347633;13849.79225311601;11278.323300601991;11850.644480665595;11911.583094591995;11983.221090629082;12070.698232544257;11345.319280843176;11583.536658533565;11614.187006909435;11627;11718.296902185895;9883.209343252667;11602.18784685064;11809.350485723367;11824.586139485076;12067.275963442222;8408.495490270603;8749.518776467356;8862.379633425599;8892.244159246537;8913.242374398249;9289.72130836076;11938.403079846146;11976.46105925253;12157.574484893341;12312.322822244863 02:24:42 INFO - PROCESS | 22014 | |3;mootools.html;1423.7864320351946;1471.9926400367997;1617.191404297851;1756.9458325005007;1814.4103166470893;7936;8581.785455363619;8643.783905402368;9156.58795354209;9185.127412895765;8714.215720585145;8972;8991.505467199302;9047.095290470967;9086;2365.988170059152;2387.8209134314907;2402.37538240058;2407.2417188585628;2417.129833260025;2377;2378.9286321410386;2394.545036443079;2395.7244916834525;2400.087966572709;2330.4406942333885;2335.4511689752894;2339.263132113387;2391;2407.5305315463493;2286.6912966749524;2307.699999000119;2310.4916918278036;2312.1791763923816;2332.4518738096535;2310.2145270607907;2320.93037208884;2343.203310874311;2343.332150337146;2354.258408601302;9041.186293233575;9065.909340906572;9090.090990900922;9114.81770364589;9140.680076197368;5245.632805703603;5275.366955965271;5309.283246761676;5331.573474122061;5341.893162136736;3410.198603328216;3509.4209455439823;3530.75284730069;3533.8586456541707;3560.2167523144867;1185.8161984892356;1201.303244118418;1204.740980689156;1212.7695737809788;1228.8648248692725;12868.485260589565;12878.549250776177;12948.546800861925;12957.416916238697;12963.287019213845;4469.910601787946;4495.730256184639;4575.130725162208;4610.05493873755;4622.445306563167;9890.950545247371;9908.455034973145;9960.850587241197;9972.30193886421;9983.750406239757;5297.099493086184;5334.14653655421;5344.225087362389;5363.892722145613;5367.731613419392;4506.526814684476;4853.272009198648;4946.233333833262;4974.726390048582;5000.224965130411;3847.8076096195077;3946.743461674982;4004.4794176756836;4036.8385264589674;4158.293090174678;1209.8548174218975;1210.8546974363132;1216.7870622641003;1231.8275441438207;1235.7466719322517;1006.4866917871792;1011.8785745710562;1013.9695809125737;1031.8761748590218;1033.7725700345911;6174.66039367839;6244.1570387997945;6292.056191571301;6330.746770129143;6479.1901012373455;474.82194177183555;476.7449414563192;480.3827082199357;481.12675493979015;484.3146947069927;4316.892077698019;4320.589543993316;4373.868783936487;4374.868753937387;4434.3348497724955;11067.50196241171;11296.491657875415;11364.659060228207;11382.203245772716;11428.085753139729;11139.33164010162;11237;11266.830997535044;11386.032187264009;11397.259178153394;8029.839403211903;8357;8366.03790564093;8508.064112947572;8577.356698247657;5798.420157984167;5991.101334799815;6039.607425517327;6202.038684003986;6264.59280146789;10296.073353397931;10427.478626068818;10538.262321637412;10567.418791966516;10633.840492392466;9688;9999.60001599957;10058.19534437258;10195.592176312864;10464.424456654957;7703.884441733267;8269.131741167332;8381.706640267561;8420.663173472993;8475.618597163266;8837.381383303107;8886.37795354319;8936.28509719208;8951.328650351119;8979.10208979097;7900.367970562226;8023.438359315025;8093.19068093186;8123.593820308843;8172.264496195133;7868.763937081897;7902.407319450949;7979.281864632211;7980.082290536662;8028.956235689323;7342.559446433231;7345.3021962913435;7400.259974002772;7424.480286379901;7462;5302.098643230583;5387.784488620411;5409.513143817076;5431.131019036935;5450.5367043801725;4985.52637499437;5209.583233341399;5360.865978350573;5430.15832545956;5527.115661494303 02:24:42 INFO - PROCESS | 22014 | |4;prototype.html;322.8886034318161;336.32063232270815;339.94390925497294;344.1327853808403;346.13984249140896;5453.263809385731;5463.726813659321;5547.0015397228535;5608.83173504795;5623.397331760449;5489.176623506476;5509.696966666842;5522.502974732273;5530.861728456781;5554.666879948813;4335.65594665653;4369.978150109253;4379.737215767048;4393.51671316155;4400;4110.9106086886995;4328.696991210617;4328.870133895973;4359.2589259825745;4392.363107349448;4250.553691862357;4273.209456250588;4276.994906197041;4309.26742453782;4316.3023110555905;4305.547917468668;4316.6546676265825;4323.41633879427;4332.631726303268;4346.652267818598;3708.647678470541;3750.342320810632;3808.067023579213;3816.8282427290837;3828.8468461261796;5327;5385.892282154335;5401.162819762943;5420.430854760272;5441.564674826044;4872.074305881871;4895.0944075345815;4901.862807803009;4919.950800491985;4933.210686290176;5460.672359658433;5760.337561180476;5767.1637612546365;5807.622504537191;5830.47525722687;4148.149629325981;4161.25097482456;4164.6251837334485;4165.333866453412;4173.165366926627;6040.818775436744;6062.969685151546;6068.180795592582;6098.32918378978;6107.938920610782;4168.187203495289;4260.446142001582;4262.104957958802;4266.893327666833;4276.5723427656985;4275.444192254987;4294.742315461082;4304.268274393298;4306.698531102793;4341.45731783527;4924.655274130777;4931.4821943696115;4952.975235123801;4958.983408401341;4973.5523802857915;5805.390434004453;5867.149263356875;5888.352281249059;5941.910871336933;6010.759569617254;1464.1873760063054;1472.6157412032655;1491.8731907787742;1493.4399600149943;1499.6850661361236;907.3208531758677;945.3193700535603;951.5622813505727;953.4184147669915;960.8606752020918;4966.602671786321;5010.3737032870895;5039.924401133986;5059.342285502861;5075.568576671024;5296.3379577552805;5337.51962323385;5364.383095943938;5376.973115134399;5390.434004429557;4901.211057963817;5071.3153724247495;5108.948910510847;5138.640295179302;5163.690178589221;2832.074189551125;2848.957265641017;2877.438899414594;2932.8093673911126;2946.425447037807;5482.972585137049;5559.444055594408;5587.3015873015875;5589.552835773128;5654.671152279211;5179.663321884065;5213.348331458567;5390.4879036491475;5420.942916131316;5467.917981230285;5531;5558.916616250759;5577.163425486209;5610.85972850682;5646.124850648156;5304.336957880265;5382.892342153056;5429.429909859566;5461.754221060141;5581.972090139523;5953.613015154001;5970.3432622412365;5987.592915664728;5987.88024239504;6033.401148695687;6105.358937311518;6351.333110023381;6358.173437453286;6366;6375.298717141203;4273.957260427356;4374.365716971085;4407.867763967086;4425.822967081281;4433.135538569948;5973.283206015306;5992.460678538952;6030.427109424598;6047.395260473917;6085.604435711664;5779.971100144472;5867.501262392574;5883.176355310346;5957.851053723692;5976.701164941823;5677.659340439587;5721.685307308138;5759.884802304015;5804.448577385142;5857.719676980904;5767.221425107557;5769.249997500298;5772.336181339032;5805.680687562224;5809.070548712186;5651.915221271602;5999.430054144849;6003.609765365237;6017.157597936205;6023.427774361428;5813.244278243801;5827.358990510956;5834.212381328636;5857.736401861841;5882.852928676646 02:24:42 INFO - PROCESS | 22014 | |5;yui.html;763.6487215880694;798.744401791427;841.0790184747701;855.8887344645198;864.3301441382931;13199.406026728797;14575.854241457595;15239.390424383011;15337.76993345098;15559;14147.080439771407;14193.858061419409;14226.78659820101;14271.928640356784;14384.065035772668;684.7021545627643;788.4402074527093;793.1592511937365;809.348474478045;818.0837462042521;813.4265342933218;813.6216659253446;814.8370325934807;818.378032695153;818.9426740128193;853.9701110461135;859.179483593167;863.3179787967498;864.7535452396069;865.7705707987388;855.7774978505603;856.404798664925;857.0358346859783;860.1355637584188;861.2851333393269;622.5984240165068;624.3631495874229;625.1435533319336;629.2071989293478;629.4523764325066;14564.781528277084;14600.853991460055;14602.415903363853;14626.268686565629;14632.122072675673;14487.71024579513;14633;14634.634134146625;14656.41374345025;14708.926455367655;11908.464119114575;11951.342676152808;12010.399480025964;12092.576759813452;12331.321777302244;3939.684825213976;3941.487606611151;3953.189596132786;3993.221321842242;4001.679865610773;56706.43293567094;57652.42347576513;59056.40943590552;59128.704356478804;59254.70372648152;11414.258073225214;11654.125940554322;11762.70593235176;11797.764044719057;11812.564263823633;18744.25022999092;20758.48103797387;20769.89615051915;20856.79143208579;20866.183065285994;8713.172248636369;8715.084916083846;8729.43258688196;8826.5586720665;8830.116988301246;4677.906441871143;4771.260454629538;4776.617870570346;4781.282807578891;4815.3499277597775;3560.7863528187872;3637.217998130415;3653.2510835278704;3660.7803531788177;3672.59601443841;664.7706541243264;669.2872091222832;686.5743239191634;693.5284006875373;711.9181294151239;677.9593324247355;691.2223748283182;710.3039021758706;751.4702134994816;803.4897839871724;10111.241656875764;10176.338537995007;10201.642942496977;10346.22403319754;10432.68701938943;669.3039239191187;726.1358982810439;797.5573556676101;803.3171803966582;813.3046245460047;4696;4866;4993.525615066563;5005.599552035828;5020.447750747415;77166.61416692992;78096.60951695319;78392.60803696059;78433.60783196047;80242.59878700686;66947.66526167338;68335.65832170907;68370.3162968374;68655.3134468659;71443;59689.70155149196;60859.39140608626;61354.69322653447;61359;62203.377966220665;9348.190023894793;9465.621375144918;9695.127438530566;9831.00478943825;9841.803163936538;39943.60056399399;39971.60028399679;40230;40476;41067.383989239584;47500.52499474961;53353;54436.72781636067;55768.44231557632;56345.71827140838;12175.512979480722;12198.32909190003;12219.938900305442;12312.076594255646;12363.93818030904;13337.933310333387;13726.519571814939;13997.370118344495;14138.363773630417;14184.432622695389;12578.559750409058;12676.683082923;12752.234865908074;12760.489580416679;13285.734285314433;13094.934525327693;13097.672558186121;13107.410166542339;13156.60530184096;13205.801912971121;11340.773184536098;11410.14423918226;11488.19582629208;11542.538298467967;11714.472848721658;10098.141657959155;10171.64399246023;10236.744081397726;10273.743156420851;10485.528151233366;10521.579136834442;10870.728231793952;10950.507227174638;11069;11092.112630989663 02:24:42 INFO - PROCESS | 22014 | __end_tp_report 02:24:42 INFO - PROCESS | 22014 | __start_cc_report 02:24:42 INFO - PROCESS | 22014 | _x_x_mozilla_cycle_collect,334 02:24:42 INFO - PROCESS | 22014 | __end_cc_report 02:24:42 INFO - PROCESS | 22014 | __startTimestamp1463649882962__endTimestamp 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | ------- Summary: start ------- 02:24:42 INFO - PROCESS | 22014 | Number of tests: 6 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#0] dojo.html Cycles:165 Average:5370.57 Median:5613.92 stddev:752.41 (13.4%) stddev-sans-first:733.73 02:24:42 INFO - PROCESS | 22014 | Values: 3121.1 3135.8 3136.4 3144.7 3173.3 5199.9 5290.7 5300.2 5405.3 5429.0 5400.0 5411.9 5412.3 5487.9 5583.6 4869.2 4885.9 4895.8 4926.8 4969.9 66.6 4905.2 4948.5 4968.2 5016.0 4907.5 4915.3 4921.2 4927.5 4944.5 4873.9 4894.4 4912.7 4921.1 4926.0 4715.1 4822.9 4827.9 4847.1 4910.9 5179.7 5210.4 5210.8 5314.5 5333.7 5784.3 5786.3 5801.8 5822.2 5853.0 5742.0 5767.7 5768.6 5813.2 5841.7 5371.8 5402.6 5409.9 5410.0 5414.1 5854.0 5945.9 5949.7 5950.3 5953.4 5697.8 5755.4 5780.4 5806.3 5834.4 5861.1 5862.3 5864.9 5870.1 5883.8 5681.4 5743.6 5755.2 5838.2 5853.4 5515.4 5778.7 5791.0 5839.5 5876.1 4426.2 4429.3 4453.8 4469.1 4527.7 3858.2 3950.2 3957.4 3978.4 4016.0 5620.6 5624.0 5681.6 5706.0 5711.5 5787.1 5811.4 5868.1 5898.5 5958.8 5408.2 5569.2 5587.5 5609.1 5611.1 4975.2 5014.2 5030.5 5049.2 5050.2 5991.1 6034.6 6049.2 6063.7 6086.8 5536.8 5800.6 5800.9 5851.6 5878.7 6103.0 6107.9 6122.0 6123.5 6127.3 5634.9 5774.4 5777.2 5777.9 5789.0 5866.5 5885.1 5910.5 5912.4 5933.5 5713.8 5736.7 5799.6 5803.4 5805.6 5536.1 5570.1 5730.4 5740.9 5764.9 5506.0 5518.1 5533.3 5534.9 5597.6 5610.0 5700.6 5774.2 5774.4 5782.0 5437.0 5591.2 5610.3 5613.9 5649.4 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#1] ext.html Cycles:180 Average:58493.31 Median:41287.79 stddev:116984.98 (283.3%) stddev-sans-first:117232.36 02:24:42 INFO - PROCESS | 22014 | Values: 586.1 604.6 623.3 629.9 630.5 32498.7 43321.8 43992.8 44041.6 47331.3 45552.5 45696.5 45699.3 45929.8 46093.3 8737.3 8795.4 8829.4 8863.8 8881.5 8638.4 8873.6 8885.7 8885.8 8923.0 8898.5 8915.4 8926.9 8966.9 8970.7 8847.3 8918.0 8953.2 8965.9 8970.4 8648.6 8737.1 8742.6 8750.0 8754.2 42336.4 42944.4 43219.8 43293.4 43582.3 3544.4 3590.4 3684.9 3826.8 3984.2 32074.5 32588.3 33034.0 33147.3 33616.0 4053.2 4100.9 4147.8 4152.6 4228.0 341256.0 344196.0 345145.0 345349.0 348829.0 34758.5 56033.4 56659.0 56810.4 56870.0 35569.1 36891.6 37108.8 37140.6 37303.8 15276.8 15323.5 15397.2 15405.6 15492.5 12393.8 12496.4 12586.8 12587.9 12645.9 8381.0 8400.6 8408.0 8447.8 8497.8 3246.2 3298.3 3309.6 3312.3 3326.9 1000.7 1001.7 1053.9 1069.3 1129.7 30229.0 30232.2 30736.5 30919.4 31293.2 1097.6 1097.9 1104.6 1146.5 1158.9 16132.8 16163.4 16288.0 16550.0 16756.0 524624.0 524767.0 530031.0 530402.0 535713.0 58114.7 58121.0 58233.1 58442.7 58583.7 1377.6 1387.4 1400.2 1405.1 1409.3 30341.2 30633.5 31083.1 31325.7 31495.0 50425.0 50584.7 50622.0 50640.5 50742.5 424723.0 426977.0 428913.0 429925.0 431401.0 26107.1 28034.3 28890.3 29098.1 30333.0 48190.8 48706.0 48910.4 49643.0 49673.3 39633.0 40389.8 40627.6 40862.6 42302.2 40829.0 40884.2 41346.4 42448.4 42861.6 41273.0 41302.6 41897.8 42306.6 44806.0 35288.5 36403.1 38632.8 38857.4 39069.0 26987.5 27186.3 27560.3 27814.8 27816.9 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#2] jquery.html Cycles:180 Average:27311.71 Median:12669.26 stddev:70651.35 (557.7%) stddev-sans-first:70820.65 02:24:42 INFO - PROCESS | 22014 | Values: 397.8 403.1 406.9 408.4 417.9 13776.8 19002.7 19116.5 19777.7 19848.7 18443.3 18784.7 19023.9 19027.6 19243.1 5373.5 5435.2 5582.9 5674.7 5699.6 5588.5 5597.2 5612.4 5614.4 5632.7 5402.8 5585.9 5593.2 5598.7 5603.2 5548.8 5551.5 5554.2 5555.0 5580.8 4781.8 4974.9 4991.5 5007.4 5023.7 22182.9 22712.5 22821.5 22872.0 22922.2 2416.3 2418.5 2422.2 2517.4 2693.9 13890.9 14281.4 14313.8 14657.6 14703.3 1895.4 2002.8 2069.1 2074.9 2075.2 81404.7 81530.0 81670.6 82371.8 82685.6 10340.9 10385.3 10632.4 10685.4 10764.2 14715.5 14750.0 14833.3 14966.7 14988.9 7924.5 8193.4 8280.1 8314.2 8344.0 7801.5 7848.5 7868.8 8034.4 8084.6 6448.7 6472.1 6474.8 6538.3 6809.0 1947.7 1952.3 1952.8 1958.2 1979.9 934.6 1036.2 1058.0 1061.4 1092.7 18209.4 18269.0 18646.2 18805.5 18930.0 1013.5 1022.7 1034.4 1037.9 1051.3 10740.4 10916.1 11083.9 11109.4 11173.4 423672.0 425715.0 425860.0 427778.0 428234.0 83322.6 89481.0 90355.0 90762.5 92936.5 1030.9 1044.8 1082.3 1088.6 1089.6 16883.3 16919.7 16994.7 17074.8 17407.9 41485.0 41745.6 43200.4 43544.0 44683.8 58976.0 59361.0 59973.0 60663.0 61108.7 8578.9 8687.7 8688.4 8781.0 8840.8 9741.0 12794.0 13267.1 13368.7 13849.8 11278.3 11850.6 11911.6 11983.2 12070.7 11345.3 11583.5 11614.2 11627.0 11718.3 9883.2 11602.2 11809.4 11824.6 12067.3 8408.5 8749.5 8862.4 8892.2 8913.2 9289.7 11938.4 11976.5 12157.6 12312.3 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#3] mootools.html Cycles:180 Average:5945.92 Median:478.56 stddev:3411.04 (712.8%) stddev-sans-first:3403.68 02:24:42 INFO - PROCESS | 22014 | Values: 1423.8 1472.0 1617.2 1756.9 1814.4 7936.0 8581.8 8643.8 9156.6 9185.1 8714.2 8972.0 8991.5 9047.1 9086.0 2366.0 2387.8 2402.4 2407.2 2417.1 2377.0 2378.9 2394.5 2395.7 2400.1 2330.4 2335.5 2339.3 2391.0 2407.5 2286.7 2307.7 2310.5 2312.2 2332.5 2310.2 2320.9 2343.2 2343.3 2354.3 9041.2 9065.9 9090.1 9114.8 9140.7 5245.6 5275.4 5309.3 5331.6 5341.9 3410.2 3509.4 3530.8 3533.9 3560.2 1185.8 1201.3 1204.7 1212.8 1228.9 12868.5 12878.5 12948.5 12957.4 12963.3 4469.9 4495.7 4575.1 4610.1 4622.4 9891.0 9908.5 9960.9 9972.3 9983.8 5297.1 5334.1 5344.2 5363.9 5367.7 4506.5 4853.3 4946.2 4974.7 5000.2 3847.8 3946.7 4004.5 4036.8 4158.3 1209.9 1210.9 1216.8 1231.8 1235.7 1006.5 1011.9 1014.0 1031.9 1033.8 6174.7 6244.2 6292.1 6330.7 6479.2 474.8 476.7 480.4 481.1 484.3 4316.9 4320.6 4373.9 4374.9 4434.3 11067.5 11296.5 11364.7 11382.2 11428.1 11139.3 11237.0 11266.8 11386.0 11397.3 8029.8 8357.0 8366.0 8508.1 8577.4 5798.4 5991.1 6039.6 6202.0 6264.6 10296.1 10427.5 10538.3 10567.4 10633.8 9688.0 9999.6 10058.2 10195.6 10464.4 7703.9 8269.1 8381.7 8420.7 8475.6 8837.4 8886.4 8936.3 8951.3 8979.1 7900.4 8023.4 8093.2 8123.6 8172.3 7868.8 7902.4 7979.3 7980.1 8029.0 7342.6 7345.3 7400.3 7424.5 7462.0 5302.1 5387.8 5409.5 5431.1 5450.5 4985.5 5209.6 5360.9 5430.2 5527.1 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#4] prototype.html Cycles:180 Average:4799.15 Median:5390.46 stddev:1406.44 (26.1%) stddev-sans-first:1369.66 02:24:42 INFO - PROCESS | 22014 | Values: 322.9 336.3 339.9 344.1 346.1 5453.3 5463.7 5547.0 5608.8 5623.4 5489.2 5509.7 5522.5 5530.9 5554.7 4335.7 4370.0 4379.7 4393.5 4400.0 4110.9 4328.7 4328.9 4359.3 4392.4 4250.6 4273.2 4277.0 4309.3 4316.3 4305.5 4316.7 4323.4 4332.6 4346.7 3708.6 3750.3 3808.1 3816.8 3828.8 5327.0 5385.9 5401.2 5420.4 5441.6 4872.1 4895.1 4901.9 4920.0 4933.2 5460.7 5760.3 5767.2 5807.6 5830.5 4148.1 4161.3 4164.6 4165.3 4173.2 6040.8 6063.0 6068.2 6098.3 6107.9 4168.2 4260.4 4262.1 4266.9 4276.6 4275.4 4294.7 4304.3 4306.7 4341.5 4924.7 4931.5 4953.0 4959.0 4973.6 5805.4 5867.1 5888.4 5941.9 6010.8 1464.2 1472.6 1491.9 1493.4 1499.7 907.3 945.3 951.6 953.4 960.9 4966.6 5010.4 5039.9 5059.3 5075.6 5296.3 5337.5 5364.4 5377.0 5390.4 4901.2 5071.3 5108.9 5138.6 5163.7 2832.1 2849.0 2877.4 2932.8 2946.4 5483.0 5559.4 5587.3 5589.6 5654.7 5179.7 5213.3 5390.5 5420.9 5467.9 5531.0 5558.9 5577.2 5610.9 5646.1 5304.3 5382.9 5429.4 5461.8 5582.0 5953.6 5970.3 5987.6 5987.9 6033.4 6105.4 6351.3 6358.2 6366.0 6375.3 4274.0 4374.4 4407.9 4425.8 4433.1 5973.3 5992.5 6030.4 6047.4 6085.6 5780.0 5867.5 5883.2 5957.9 5976.7 5677.7 5721.7 5759.9 5804.4 5857.7 5767.2 5769.2 5772.3 5805.7 5809.1 5651.9 5999.4 6003.6 6017.2 6023.4 5813.2 5827.4 5834.2 5857.7 5882.9 02:24:42 INFO - PROCESS | 22014 | 02:24:42 INFO - PROCESS | 22014 | [#5] yui.html Cycles:180 Average:16680.38 Median:4686.95 stddev:20772.67 (443.2%) stddev-sans-first:20796.56 02:24:42 INFO - PROCESS | 22014 | Values: 763.6 798.7 841.1 855.9 864.3 13199.4 14575.9 15239.4 15337.8 15559.0 14147.1 14193.9 14226.8 14271.9 14384.1 684.7 788.4 793.2 809.3 818.1 813.4 813.6 814.8 818.4 818.9 854.0 859.2 863.3 864.8 865.8 855.8 856.4 857.0 860.1 861.3 622.6 624.4 625.1 629.2 629.5 14564.8 14600.9 14602.4 14626.3 14632.1 14487.7 14633.0 14634.6 14656.4 14708.9 11908.5 11951.3 12010.4 12092.6 12331.3 3939.7 3941.5 3953.2 3993.2 4001.7 56706.4 57652.4 59056.4 59128.7 59254.7 11414.3 11654.1 11762.7 11797.8 11812.6 18744.3 20758.5 20769.9 20856.8 20866.2 8713.2 8715.1 8729.4 8826.6 8830.1 4677.9 4771.3 4776.6 4781.3 4815.3 3560.8 3637.2 3653.3 3660.8 3672.6 664.8 669.3 686.6 693.5 711.9 678.0 691.2 710.3 751.5 803.5 10111.2 10176.3 10201.6 10346.2 10432.7 669.3 726.1 797.6 803.3 813.3 4696.0 4866.0 4993.5 5005.6 5020.4 77166.6 78096.6 78392.6 78433.6 80242.6 66947.7 68335.7 68370.3 68655.3 71443.0 59689.7 60859.4 61354.7 61359.0 62203.4 9348.2 9465.6 9695.1 9831.0 9841.8 39943.6 39971.6 40230.0 40476.0 41067.4 47500.5 53353.0 54436.7 55768.4 56345.7 12175.5 12198.3 12219.9 12312.1 12363.9 13337.9 13726.5 13997.4 14138.4 14184.4 12578.6 12676.7 12752.2 12760.5 13285.7 13094.9 13097.7 13107.4 13156.6 13205.8 11340.8 11410.1 11488.2 11542.5 11714.5 10098.1 10171.6 10236.7 10273.7 10485.5 10521.6 10870.7 10950.5 11069.0 11092.1 02:24:42 INFO - PROCESS | 22014 | -------- Summary: end -------- 02:24:42 INFO - PROCESS | 22014 | 02:24:43 INFO - PROCESS | 22014 | 02:24:43 INFO - PROCESS | 22014 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 02:24:43 INFO - PROCESS | 22014 | 02:24:43 INFO - PROCESS | 22014 | 02:24:43 INFO - PROCESS | 22014 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 02:24:43 INFO - PROCESS | 22014 | 02:24:43 INFO - TEST-INFO | 22014: exit 0 02:24:43 INFO - TEST-OK | dromaeo_css | took 1109216ms 02:24:43 INFO - TEST-START | kraken 02:24:43 INFO - operating with platform_type : linux_ 02:24:43 INFO - Initialising browser for kraken test... 02:24:43 INFO - TEST-INFO | started process 22248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNOYin/profile http://localhost:41029/getInfo.html) 02:24:47 INFO - PROCESS | 22248 | 02:24:47 INFO - PROCESS | 22248 | (process:22316): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:24:48 INFO - PROCESS | 22248 | __metrics Screen width/height:1600/1200 02:24:48 INFO - PROCESS | 22248 | colorDepth:24 02:24:48 INFO - PROCESS | 22248 | Browser inner width/height: 1024/697 02:24:48 INFO - PROCESS | 22248 | __metrics 02:24:48 ERROR - PROCESS | 22248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:24:49 INFO - TEST-INFO | 22248: exit 0 02:24:49 INFO - Browser initialized. 02:24:49 INFO - Running cycle 1/1 for kraken test... 02:24:49 INFO - TEST-INFO | started process 22367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNOYin/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:51 INFO - PROCESS | 22367 | 02:24:51 INFO - PROCESS | 22367 | (process:22431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:25:01 INFO - PROCESS | 22367 | RSS: Main: 164024320 02:25:01 INFO - PROCESS | 22367 | 02:25:04 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41029/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:04 INFO - PROCESS | 22367 | RSS: Main: 168693760 02:25:04 INFO - PROCESS | 22367 | 02:25:07 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41029/tests/kraken/driver.html?testName=audio-dft) 02:25:08 INFO - PROCESS | 22367 | RSS: Main: 168501248 02:25:08 INFO - PROCESS | 22367 | 02:25:11 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41029/tests/kraken/driver.html?testName=audio-fft) 02:25:11 INFO - PROCESS | 22367 | RSS: Main: 163373056 02:25:11 INFO - PROCESS | 22367 | 02:25:14 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41029/tests/kraken/driver.html?testName=audio-oscillator) 02:25:14 INFO - PROCESS | 22367 | RSS: Main: 164192256 02:25:14 INFO - PROCESS | 22367 | 02:25:16 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41029/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:17 INFO - PROCESS | 22367 | RSS: Main: 164413440 02:25:17 INFO - PROCESS | 22367 | 02:25:20 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41029/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:21 INFO - PROCESS | 22367 | RSS: Main: 164626432 02:25:21 INFO - PROCESS | 22367 | 02:25:24 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41029/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:25 INFO - PROCESS | 22367 | RSS: Main: 163328000 02:25:25 INFO - PROCESS | 22367 | 02:25:28 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41029/tests/kraken/driver.html?testName=json-parse-financial) 02:25:29 INFO - PROCESS | 22367 | RSS: Main: 163672064 02:25:29 INFO - PROCESS | 22367 | 02:25:30 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41029/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:25:31 INFO - PROCESS | 22367 | RSS: Main: 163856384 02:25:31 INFO - PROCESS | 22367 | 02:25:33 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:25:33 INFO - PROCESS | 22367 | RSS: Main: 163893248 02:25:33 INFO - PROCESS | 22367 | 02:25:36 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:25:36 INFO - PROCESS | 22367 | RSS: Main: 164536320 02:25:36 INFO - PROCESS | 22367 | 02:25:39 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:25:39 INFO - PROCESS | 22367 | RSS: Main: 164499456 02:25:39 INFO - PROCESS | 22367 | 02:25:42 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:25:43 INFO - PROCESS | 22367 | RSS: Main: 164466688 02:25:43 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | Cycle 1(1): loaded http://localhost:41029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41029/tests/kraken/driver.html?testName=ai-astar) 02:25:45 INFO - PROCESS | 22367 | RSS: Main: 166047744 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | __start_tp_report 02:25:45 INFO - PROCESS | 22367 | _x_x_mozilla_page_load 02:25:45 INFO - PROCESS | 22367 | _x_x_mozilla_page_load_details 02:25:45 INFO - PROCESS | 22367 | |i|pagename|runs| 02:25:45 INFO - PROCESS | 22367 | |0;ai-astar;107;109;105;112;110;113;108;113;112;111 02:25:45 INFO - PROCESS | 22367 | |1;audio-beat-detection;155;135;156;213;128;157;150;130;180;133 02:25:45 INFO - PROCESS | 22367 | |2;audio-dft;163;164;165;166;168;175;165;163;164;164 02:25:45 INFO - PROCESS | 22367 | |3;audio-fft;75;76;74;161;77;75;75;78;171;76 02:25:45 INFO - PROCESS | 22367 | |4;audio-oscillator;97;93;185;93;93;94;139;93;92;145 02:25:45 INFO - PROCESS | 22367 | |5;imaging-gaussian-blur;119;118;117;118;118;117;117;117;118;118 02:25:45 INFO - PROCESS | 22367 | |6;imaging-darkroom;148;147;148;148;148;147;148;148;147;147 02:25:45 INFO - PROCESS | 22367 | |7;imaging-desaturate;96;96;95;96;102;100;99;96;95;95 02:25:45 INFO - PROCESS | 22367 | |8;json-parse-financial;57;57;56;55;61;57;59;55;57;58 02:25:45 INFO - PROCESS | 22367 | |9;json-stringify-tinderbox;62;61;61;63;62;61;61;61;62;61 02:25:45 INFO - PROCESS | 22367 | |10;stanford-crypto-aes;78;79;84;78;85;80;79;81;135;86 02:25:45 INFO - PROCESS | 22367 | |11;stanford-crypto-ccm;130;120;130;121;123;121;121;123;144;133 02:25:45 INFO - PROCESS | 22367 | |12;stanford-crypto-pbkdf2;162;168;170;162;164;163;163;163;165;165 02:25:45 INFO - PROCESS | 22367 | |13;stanford-crypto-sha256-iterative;64;63;69;65;65;63;65;64;64;64 02:25:45 INFO - PROCESS | 22367 | __end_tp_report 02:25:45 INFO - PROCESS | 22367 | __start_cc_report 02:25:45 INFO - PROCESS | 22367 | _x_x_mozilla_cycle_collect,853 02:25:45 INFO - PROCESS | 22367 | __end_cc_report 02:25:45 INFO - PROCESS | 22367 | __startTimestamp1463649945411__endTimestamp 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | ------- Summary: start ------- 02:25:45 INFO - PROCESS | 22367 | Number of tests: 14 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:2.71 (2.4%) stddev-sans-first:2.65 02:25:45 INFO - PROCESS | 22367 | Values: 107.0 109.0 105.0 112.0 110.0 113.0 108.0 113.0 112.0 111.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:155.50 stddev:26.33 (16.9%) stddev-sans-first:27.92 02:25:45 INFO - PROCESS | 22367 | Values: 155.0 135.0 156.0 213.0 128.0 157.0 150.0 130.0 180.0 133.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:3.59 (2.2%) stddev-sans-first:3.67 02:25:45 INFO - PROCESS | 22367 | Values: 163.0 164.0 165.0 166.0 168.0 175.0 165.0 163.0 164.0 164.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.14 (50.5%) stddev-sans-first:39.84 02:25:45 INFO - PROCESS | 22367 | Values: 75.0 76.0 74.0 161.0 77.0 75.0 75.0 78.0 171.0 76.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:93.00 stddev:32.55 (35.0%) stddev-sans-first:34.05 02:25:45 INFO - PROCESS | 22367 | Values: 97.0 93.0 185.0 93.0 93.0 94.0 139.0 93.0 92.0 145.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 02:25:45 INFO - PROCESS | 22367 | Values: 119.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 02:25:45 INFO - PROCESS | 22367 | Values: 148.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 147.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.45 (2.6%) stddev-sans-first:2.57 02:25:45 INFO - PROCESS | 22367 | Values: 96.0 96.0 95.0 96.0 102.0 100.0 99.0 96.0 95.0 95.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.92 02:25:45 INFO - PROCESS | 22367 | Values: 57.0 57.0 56.0 55.0 61.0 57.0 59.0 55.0 57.0 58.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:25:45 INFO - PROCESS | 22367 | Values: 62.0 61.0 61.0 63.0 62.0 61.0 61.0 61.0 62.0 61.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:80.50 stddev:17.29 (21.5%) stddev-sans-first:18.06 02:25:45 INFO - PROCESS | 22367 | Values: 78.0 79.0 84.0 78.0 85.0 80.0 79.0 81.0 135.0 86.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:126.50 stddev:7.68 (6.1%) stddev-sans-first:8.04 02:25:45 INFO - PROCESS | 22367 | Values: 130.0 120.0 130.0 121.0 123.0 121.0 121.0 123.0 144.0 133.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:2.64 (1.6%) stddev-sans-first:2.64 02:25:45 INFO - PROCESS | 22367 | Values: 162.0 168.0 170.0 162.0 164.0 163.0 163.0 163.0 165.0 165.0 02:25:45 INFO - PROCESS | 22367 | 02:25:45 INFO - PROCESS | 22367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.80 02:25:45 INFO - PROCESS | 22367 | Values: 64.0 63.0 69.0 65.0 65.0 63.0 65.0 64.0 64.0 64.0 02:25:45 INFO - PROCESS | 22367 | -------- Summary: end -------- 02:25:45 INFO - PROCESS | 22367 | 02:25:46 INFO - TEST-INFO | 22367: exit 0 02:25:46 INFO - TEST-OK | kraken | took 62671ms 02:25:46 INFO - SUITE-END | took 1171s 02:25:46 INFO - Completed test suite (00:19:32) 02:25:46 INFO - javascript benchmark 02:25:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7171.6600380672535, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.0636808957306, 3135.7961732487393, 3136.404083224187, 3144.716975472207, 3173.3177366866134, 5199.896002079956, 5290.735463226838, 5300.231466437364, 5405.297311349529, 5428.972855135728, 5400.0, 5411.891762164754, 5412.269343638608, 5487.945120548793, 5583.553315734742, 4869.196582563882, 4885.902281954359, 4895.828645997391, 4926.77886621495, 4969.850904472872, 66.62079819862021, 4905.239687848371, 4948.50514948504, 4968.229924361712, 5015.974920125413, 4907.460179380265, 4915.3364295819965, 4921.212605983043, 4927.482614325516, 4944.505549445063, 4873.853784386474, 4894.388201474816, 4912.707876997684, 4921.114199444099, 4926.0394223126505, 4715.104130215248, 4822.903541929142, 4827.879303017417, 4847.079054979577, 4910.90178196434, 5179.689218646893, 5210.4268530461995, 5210.76551555181, 5314.468553144693, 5333.679979201261, 5784.2769653793275, 5786.255270678045, 5801.767929282823, 5822.243108395882, 5853.034249348852, 5741.9951508486265, 5767.711614419262, 5768.596198266123, 5813.157092221604, 5841.707914604295, 5371.785128594852, 5402.594805389612, 5409.891802163974, 5410.0, 5414.052540805383, 5853.970730146322, 5945.910811337833, 5949.732262048175, 5950.315713692894, 5953.374895635896, 5697.772089116389, 5755.424457554295, 5780.421957804186, 5806.274215723035, 5834.358220595731, 5861.120831875252, 5862.325832529314, 5864.8533786654825, 5870.148828419855, 5883.764649414061, 5681.375048744635, 5743.569232307594, 5755.194272801811, 5838.153467747238, 5853.414658534112, 5515.420880807537, 5778.739956701958, 5790.971045144747, 5839.532837373, 5876.118582212703, 4426.22541055314, 4429.313456414261, 4453.844115455943, 4469.106178764195, 4527.660425468103, 3858.1897801462005, 3950.190211006794, 3957.426173204869, 3978.403239514096, 4016.0, 5620.578456615688, 5623.971880140573, 5681.57388195887, 5706.0, 5711.543076553866, 5787.102999035156, 5811.418858114154, 5868.09044598088, 5898.469137777534, 5958.821235362946, 5408.215808707794, 5569.164625306236, 5587.497125258747, 5609.074502707008, 5611.102223644198, 4975.228839529878, 5014.172661510883, 5030.4718004608985, 5049.166887463527, 5050.191969284897, 5991.101334799815, 6034.577579569388, 6049.243844519435, 6063.6664983426335, 6086.756529738761, 5536.806211782568, 5800.622959507618, 5800.912986305293, 5851.561132914963, 5878.735456904364, 6102.9694851525455, 6107.9083813741945, 6121.969390153021, 6123.510119190543, 6127.29536103336, 5634.85912852182, 5774.364819869895, 5777.2200752897825, 5777.91333129995, 5788.957987562279, 5866.50134738552, 5885.117232415172, 5910.468057874812, 5912.438318359921, 5933.465988060922, 5713.771449142154, 5736.71316434185, 5799.594028417971, 5803.419658034163, 5805.593608447537, 5536.058869992031, 5570.136628822539, 5730.398308177581, 5740.913886291625, 5764.884702306014, 5506.03644362243, 5518.117101263779, 5533.280673512418, 5534.91697624544, 5597.63615365, 5609.971950140223, 5700.572457065819, 5774.220480235114, 5774.422557744192, 5781.971090144522, 5437.0, 5591.217229587943, 5610.270664813548, 5613.915791263216, 5649.37856835756], "value": 5321.553249496672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.114966400735, 604.6100265328862, 623.2925629410619, 629.9118123462713, 630.4987534909743, 32498.67501324989, 43321.78339108304, 43992.780036099815, 44041.559584404225, 47331.290030649565, 45552.544474555245, 45696.543034569644, 45699.31451028237, 45929.77035114828, 46093.30860037102, 8737.257333126676, 8795.428297160695, 8829.381943263974, 8863.77840553988, 8881.511516866569, 8638.395312328108, 8873.600687969058, 8885.733427997171, 8885.822283554326, 8923.0, 8898.466092034467, 8915.420497667663, 8926.910730892705, 8966.910330896673, 8970.686025989091, 8847.33644976626, 8918.019017908058, 8953.23897468716, 8965.910340896606, 8970.372073954826, 8648.567571621394, 8737.126287371275, 8742.606582703793, 8750.03749587545, 8754.212120909086, 42336.36495452571, 42944.355834662194, 43219.783901080606, 43293.35059974103, 43582.34626480605, 3544.362014837354, 3590.4075827488696, 3684.907877303062, 3826.770393776382, 3984.2429938311916, 32074.518882216784, 32588.34823303544, 33034.0, 33147.33705325904, 33616.0, 4053.2298863215897, 4100.876973690794, 4147.751134931914, 4152.6055024772595, 4228.04868904494, 341256.0, 344196.0, 345145.0, 345349.0, 348829.0, 34758.47862282068, 56033.43966560364, 56659.0, 56810.431895681344, 56870.0, 35569.110772230386, 36891.63108368882, 37108.814455928084, 37140.62859371426, 37303.81348093242, 15276.847231527765, 15323.46367877119, 15397.23013849303, 15405.614859628598, 15492.457763978207, 12393.822586854234, 12496.437660305308, 12586.81119783204, 12587.874121258854, 12645.93677031609, 8381.0, 8400.621972011275, 8407.957960210282, 8447.788805279917, 8497.830043399097, 3246.188452886778, 3298.3238436120537, 3309.5532103165765, 3312.254742682877, 3326.86692532296, 1000.6697789729371, 1001.6644424117857, 1053.8840727519967, 1069.3263244156133, 1129.7119234595125, 30229.0, 30232.244193894887, 30736.53895191574, 30919.381612368077, 31293.217669557987, 1097.6322931817772, 1097.8956999085074, 1104.6023431564631, 1146.5241924601364, 1158.9014933730728, 16132.75800862988, 16163.43427980015, 16288.022718636683, 16550.006999580062, 16756.0, 524624.0, 524767.0, 530031.0, 530402.0, 535713.0, 58114.709426453446, 58121.0, 58233.12650310249, 58442.70778646079, 58583.707081465174, 1377.579838149354, 1387.4103506009906, 1400.2368709053387, 1405.0796728143082, 1409.2812665540648, 30341.241468963453, 30633.540496892118, 31083.067507974796, 31325.686743132275, 31495.0, 50425.0, 50584.747076264386, 50622.0, 50640.493595065054, 50742.492575073775, 424723.0, 426977.0, 428913.0, 429925.0, 431401.0, 26107.08625198109, 28034.2991425216, 28890.27774305659, 29098.127056188347, 30333.0, 48190.759046205945, 48706.0, 48910.3681929143, 49643.0, 49673.25490117579, 39633.0, 40389.79805100956, 40627.59372406238, 40862.59137408588, 42302.153956921306, 40829.0, 40884.182316354105, 41346.379804302356, 42448.36327455029, 42861.571384287, 41273.0, 41302.586974129874, 41897.79051104725, 42306.57693423027, 44806.0, 35288.47067293942, 36403.07572629618, 38632.80683596564, 38857.41713874238, 39069.0, 26987.460250795266, 27186.32034199161, 27560.310992225353, 27814.84009506104, 27816.86091569529], "value": 18899.47763875525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8309218582103, 403.1030956122627, 406.906411525349, 408.399652510809, 417.8706379195376, 13776.793348099787, 19002.714959275603, 19116.522086947833, 19777.703334449994, 19848.702269465968, 18443.262269509236, 18784.71822922654, 19023.904880475613, 19027.572932030085, 19243.134058967345, 5373.462653734625, 5435.1847222916485, 5582.888342233153, 5674.659520428767, 5699.629524080921, 5588.497035266825, 5597.216389705444, 5612.438756124396, 5614.410486898878, 5632.718364081779, 5402.810901618444, 5585.916211256814, 5593.161025846115, 5598.664080155183, 5603.159526071081, 5548.77804887804, 5551.472610102034, 5554.222408862783, 5555.000099982001, 5580.776768929238, 4781.832635857763, 4974.900501989976, 4991.475895031006, 5007.4491805901325, 5023.673461225045, 22182.88908555463, 22712.545749084926, 22821.543569128524, 22872.0, 22922.19772307961, 2416.32342943976, 2418.4921166555046, 2422.2127808462146, 2517.408409023878, 2693.892244310225, 13890.93054534731, 14281.428742850274, 14313.78529322061, 14657.56027319182, 14703.264836758119, 1895.3840001999406, 2002.839772818171, 2069.14130635786, 2074.8962551872346, 2075.190675636503, 81404.7086939347, 81530.0, 81670.59164704138, 82371.7644235331, 82685.58657206675, 10340.948295258475, 10385.324953877975, 10632.362058276529, 10685.358878467317, 10764.246502744732, 14715.484958026631, 14750.0, 14833.258337083103, 14966.70066598662, 14988.925055374653, 7924.524528528192, 8193.385496087818, 8280.089190189074, 8314.168583141638, 8344.0, 7801.531908085533, 7848.489848159851, 7868.763937081897, 8034.397420193509, 8084.595770211466, 6448.678475748727, 6472.126262954535, 6474.805755827333, 6538.313477084933, 6808.9659551701925, 1947.7078438234378, 1952.3166891588114, 1952.8437724981968, 1958.1873522488008, 1979.8911059891843, 934.6121359635675, 1036.186593524095, 1057.9894201058046, 1061.4268295120703, 1092.7377429416883, 18209.362672306404, 18269.0, 18646.160922758238, 18805.529861753294, 18930.01234870346, 1013.5135135135176, 1022.7397451631828, 1034.446571084466, 1037.901399367059, 1051.348164138239, 10740.409277489813, 10916.12670986335, 11083.889161108285, 11109.44452777358, 11173.441327933571, 423672.0, 425715.0, 425860.0, 427778.0, 428234.0, 83322.58338708268, 89481.0, 90355.0, 90762.54618726997, 92936.53531732298, 1030.9381437113798, 1044.8171569975225, 1082.2694681090234, 1088.6081010836092, 1089.629525961177, 16883.32466701318, 16919.66160676755, 16994.745078824075, 17074.829251707823, 17407.91296043512, 41485.0, 41745.58254417417, 43200.35199472073, 43544.0, 44683.77658111689, 58976.0, 59361.0, 59973.0, 60663.0, 61108.69445652743, 8578.871316930376, 8687.652493900174, 8688.39181257306, 8780.956095219482, 8840.823183536164, 9741.0, 12793.976481881242, 13267.137636053625, 13368.732625347633, 13849.79225311601, 11278.323300601991, 11850.644480665595, 11911.583094591995, 11983.221090629082, 12070.698232544257, 11345.319280843176, 11583.536658533565, 11614.187006909435, 11627.0, 11718.296902185895, 9883.209343252667, 11602.18784685064, 11809.350485723367, 11824.586139485076, 12067.275963442222, 8408.495490270603, 8749.518776467356, 8862.379633425599, 8892.244159246537, 8913.242374398249, 9289.72130836076, 11938.403079846146, 11976.46105925253, 12157.574484893341, 12312.322822244863], "value": 9325.391964985045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.7864320351946, 1471.9926400367997, 1617.191404297851, 1756.9458325005007, 1814.4103166470893, 7936.0, 8581.785455363619, 8643.783905402368, 9156.58795354209, 9185.127412895765, 8714.215720585145, 8972.0, 8991.505467199302, 9047.095290470967, 9086.0, 2365.988170059152, 2387.8209134314907, 2402.37538240058, 2407.2417188585628, 2417.129833260025, 2377.0, 2378.9286321410386, 2394.545036443079, 2395.7244916834525, 2400.087966572709, 2330.4406942333885, 2335.4511689752894, 2339.263132113387, 2391.0, 2407.5305315463493, 2286.6912966749524, 2307.699999000119, 2310.4916918278036, 2312.1791763923816, 2332.4518738096535, 2310.2145270607907, 2320.93037208884, 2343.203310874311, 2343.332150337146, 2354.258408601302, 9041.186293233575, 9065.909340906572, 9090.090990900922, 9114.81770364589, 9140.680076197368, 5245.632805703603, 5275.366955965271, 5309.283246761676, 5331.573474122061, 5341.893162136736, 3410.198603328216, 3509.4209455439823, 3530.75284730069, 3533.8586456541707, 3560.2167523144867, 1185.8161984892356, 1201.303244118418, 1204.740980689156, 1212.7695737809788, 1228.8648248692725, 12868.485260589565, 12878.549250776177, 12948.546800861925, 12957.416916238697, 12963.287019213845, 4469.910601787946, 4495.730256184639, 4575.130725162208, 4610.05493873755, 4622.445306563167, 9890.950545247371, 9908.455034973145, 9960.850587241197, 9972.30193886421, 9983.750406239757, 5297.099493086184, 5334.14653655421, 5344.225087362389, 5363.892722145613, 5367.731613419392, 4506.526814684476, 4853.272009198648, 4946.233333833262, 4974.726390048582, 5000.224965130411, 3847.8076096195077, 3946.743461674982, 4004.4794176756836, 4036.8385264589674, 4158.293090174678, 1209.8548174218975, 1210.8546974363132, 1216.7870622641003, 1231.8275441438207, 1235.7466719322517, 1006.4866917871792, 1011.8785745710562, 1013.9695809125737, 1031.8761748590218, 1033.7725700345911, 6174.66039367839, 6244.1570387997945, 6292.056191571301, 6330.746770129143, 6479.1901012373455, 474.82194177183555, 476.7449414563192, 480.3827082199357, 481.12675493979015, 484.3146947069927, 4316.892077698019, 4320.589543993316, 4373.868783936487, 4374.868753937387, 4434.3348497724955, 11067.50196241171, 11296.491657875415, 11364.659060228207, 11382.203245772716, 11428.085753139729, 11139.33164010162, 11237.0, 11266.830997535044, 11386.032187264009, 11397.259178153394, 8029.839403211903, 8357.0, 8366.03790564093, 8508.064112947572, 8577.356698247657, 5798.420157984167, 5991.101334799815, 6039.607425517327, 6202.038684003986, 6264.59280146789, 10296.073353397931, 10427.478626068818, 10538.262321637412, 10567.418791966516, 10633.840492392466, 9688.0, 9999.60001599957, 10058.19534437258, 10195.592176312864, 10464.424456654957, 7703.884441733267, 8269.131741167332, 8381.706640267561, 8420.663173472993, 8475.618597163266, 8837.381383303107, 8886.37795354319, 8936.28509719208, 8951.328650351119, 8979.10208979097, 7900.367970562226, 8023.438359315025, 8093.19068093186, 8123.593820308843, 8172.264496195133, 7868.763937081897, 7902.407319450949, 7979.281864632211, 7980.082290536662, 8028.956235689323, 7342.559446433231, 7345.3021962913435, 7400.259974002772, 7424.480286379901, 7462.0, 5302.098643230583, 5387.784488620411, 5409.513143817076, 5431.131019036935, 5450.5367043801725, 4985.52637499437, 5209.583233341399, 5360.865978350573, 5430.15832545956, 5527.115661494303], "value": 4673.6663576778565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8886034318161, 336.32063232270815, 339.94390925497294, 344.1327853808403, 346.13984249140896, 5453.263809385731, 5463.726813659321, 5547.0015397228535, 5608.83173504795, 5623.397331760449, 5489.176623506476, 5509.696966666842, 5522.502974732273, 5530.861728456781, 5554.666879948813, 4335.65594665653, 4369.978150109253, 4379.737215767048, 4393.51671316155, 4400.0, 4110.9106086886995, 4328.696991210617, 4328.870133895973, 4359.2589259825745, 4392.363107349448, 4250.553691862357, 4273.209456250588, 4276.994906197041, 4309.26742453782, 4316.3023110555905, 4305.547917468668, 4316.6546676265825, 4323.41633879427, 4332.631726303268, 4346.652267818598, 3708.647678470541, 3750.342320810632, 3808.067023579213, 3816.8282427290837, 3828.8468461261796, 5327.0, 5385.892282154335, 5401.162819762943, 5420.430854760272, 5441.564674826044, 4872.074305881871, 4895.0944075345815, 4901.862807803009, 4919.950800491985, 4933.210686290176, 5460.672359658433, 5760.337561180476, 5767.1637612546365, 5807.622504537191, 5830.47525722687, 4148.149629325981, 4161.25097482456, 4164.6251837334485, 4165.333866453412, 4173.165366926627, 6040.818775436744, 6062.969685151546, 6068.180795592582, 6098.32918378978, 6107.938920610782, 4168.187203495289, 4260.446142001582, 4262.104957958802, 4266.893327666833, 4276.5723427656985, 4275.444192254987, 4294.742315461082, 4304.268274393298, 4306.698531102793, 4341.45731783527, 4924.655274130777, 4931.4821943696115, 4952.975235123801, 4958.983408401341, 4973.5523802857915, 5805.390434004453, 5867.149263356875, 5888.352281249059, 5941.910871336933, 6010.759569617254, 1464.1873760063054, 1472.6157412032655, 1491.8731907787742, 1493.4399600149943, 1499.6850661361236, 907.3208531758677, 945.3193700535603, 951.5622813505727, 953.4184147669915, 960.8606752020918, 4966.602671786321, 5010.3737032870895, 5039.924401133986, 5059.342285502861, 5075.568576671024, 5296.3379577552805, 5337.51962323385, 5364.383095943938, 5376.973115134399, 5390.434004429557, 4901.211057963817, 5071.3153724247495, 5108.948910510847, 5138.640295179302, 5163.690178589221, 2832.074189551125, 2848.957265641017, 2877.438899414594, 2932.8093673911126, 2946.425447037807, 5482.972585137049, 5559.444055594408, 5587.3015873015875, 5589.552835773128, 5654.671152279211, 5179.663321884065, 5213.348331458567, 5390.4879036491475, 5420.942916131316, 5467.917981230285, 5531.0, 5558.916616250759, 5577.163425486209, 5610.85972850682, 5646.124850648156, 5304.336957880265, 5382.892342153056, 5429.429909859566, 5461.754221060141, 5581.972090139523, 5953.613015154001, 5970.3432622412365, 5987.592915664728, 5987.88024239504, 6033.401148695687, 6105.358937311518, 6351.333110023381, 6358.173437453286, 6366.0, 6375.298717141203, 4273.957260427356, 4374.365716971085, 4407.867763967086, 4425.822967081281, 4433.135538569948, 5973.283206015306, 5992.460678538952, 6030.427109424598, 6047.395260473917, 6085.604435711664, 5779.971100144472, 5867.501262392574, 5883.176355310346, 5957.851053723692, 5976.701164941823, 5677.659340439587, 5721.685307308138, 5759.884802304015, 5804.448577385142, 5857.719676980904, 5767.221425107557, 5769.249997500298, 5772.336181339032, 5805.680687562224, 5809.070548712186, 5651.915221271602, 5999.430054144849, 6003.609765365237, 6017.157597936205, 6023.427774361428, 5813.244278243801, 5827.358990510956, 5834.212381328636, 5857.736401861841, 5882.852928676646], "value": 4347.851242892028, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.6487215880694, 798.744401791427, 841.0790184747701, 855.8887344645198, 864.3301441382931, 13199.406026728797, 14575.854241457595, 15239.390424383011, 15337.76993345098, 15559.0, 14147.080439771407, 14193.858061419409, 14226.78659820101, 14271.928640356784, 14384.065035772668, 684.7021545627643, 788.4402074527093, 793.1592511937365, 809.348474478045, 818.0837462042521, 813.4265342933218, 813.6216659253446, 814.8370325934807, 818.378032695153, 818.9426740128193, 853.9701110461135, 859.179483593167, 863.3179787967498, 864.7535452396069, 865.7705707987388, 855.7774978505603, 856.404798664925, 857.0358346859783, 860.1355637584188, 861.2851333393269, 622.5984240165068, 624.3631495874229, 625.1435533319336, 629.2071989293478, 629.4523764325066, 14564.781528277084, 14600.853991460055, 14602.415903363853, 14626.268686565629, 14632.122072675673, 14487.71024579513, 14633.0, 14634.634134146625, 14656.41374345025, 14708.926455367655, 11908.464119114575, 11951.342676152808, 12010.399480025964, 12092.576759813452, 12331.321777302244, 3939.684825213976, 3941.487606611151, 3953.189596132786, 3993.221321842242, 4001.679865610773, 56706.43293567094, 57652.42347576513, 59056.40943590552, 59128.704356478804, 59254.70372648152, 11414.258073225214, 11654.125940554322, 11762.70593235176, 11797.764044719057, 11812.564263823633, 18744.25022999092, 20758.48103797387, 20769.89615051915, 20856.79143208579, 20866.183065285994, 8713.172248636369, 8715.084916083846, 8729.43258688196, 8826.5586720665, 8830.116988301246, 4677.906441871143, 4771.260454629538, 4776.617870570346, 4781.282807578891, 4815.3499277597775, 3560.7863528187872, 3637.217998130415, 3653.2510835278704, 3660.7803531788177, 3672.59601443841, 664.7706541243264, 669.2872091222832, 686.5743239191634, 693.5284006875373, 711.9181294151239, 677.9593324247355, 691.2223748283182, 710.3039021758706, 751.4702134994816, 803.4897839871724, 10111.241656875764, 10176.338537995007, 10201.642942496977, 10346.22403319754, 10432.68701938943, 669.3039239191187, 726.1358982810439, 797.5573556676101, 803.3171803966582, 813.3046245460047, 4696.0, 4866.0, 4993.525615066563, 5005.599552035828, 5020.447750747415, 77166.61416692992, 78096.60951695319, 78392.60803696059, 78433.60783196047, 80242.59878700686, 66947.66526167338, 68335.65832170907, 68370.3162968374, 68655.3134468659, 71443.0, 59689.70155149196, 60859.39140608626, 61354.69322653447, 61359.0, 62203.377966220665, 9348.190023894793, 9465.621375144918, 9695.127438530566, 9831.00478943825, 9841.803163936538, 39943.60056399399, 39971.60028399679, 40230.0, 40476.0, 41067.383989239584, 47500.52499474961, 53353.0, 54436.72781636067, 55768.44231557632, 56345.71827140838, 12175.512979480722, 12198.32909190003, 12219.938900305442, 12312.076594255646, 12363.93818030904, 13337.933310333387, 13726.519571814939, 13997.370118344495, 14138.363773630417, 14184.432622695389, 12578.559750409058, 12676.683082923, 12752.234865908074, 12760.489580416679, 13285.734285314433, 13094.934525327693, 13097.672558186121, 13107.410166542339, 13156.60530184096, 13205.801912971121, 11340.773184536098, 11410.14423918226, 11488.19582629208, 11542.538298467967, 11714.472848721658, 10098.141657959155, 10171.64399246023, 10236.744081397726, 10273.743156420851, 10485.528151233366, 10521.579136834442, 10870.728231793952, 10950.507227174638, 11069.0, 11092.112630989663], "value": 7138.204991349008, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 105.0, 112.0, 110.0, 113.0, 108.0, 113.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 156.0, 213.0, 128.0, 157.0, 150.0, 130.0, 180.0, 133.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 166.0, 168.0, 175.0, 165.0, 163.0, 164.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 161.0, 77.0, 75.0, 75.0, 78.0, 171.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 185.0, 93.0, 93.0, 94.0, 139.0, 93.0, 92.0, 145.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 102.0, 100.0, 99.0, 96.0, 95.0, 95.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 55.0, 61.0, 57.0, 59.0, 55.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 84.0, 78.0, 85.0, 80.0, 79.0, 81.0, 135.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 130.0, 121.0, 123.0, 121.0, 121.0, 123.0, 144.0, 133.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 170.0, 162.0, 164.0, 163.0, 163.0, 163.0, 165.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 69.0, 65.0, 65.0, 63.0, 65.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 02:25:46 INFO - Return code: 0 02:25:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:25:46 ERROR - # TBPL SUCCESS # 02:25:46 INFO - Running post-action listener: _resource_record_post_action 02:25:46 INFO - ##### 02:25:46 INFO - ##### Finished run-tests step (success) 02:25:46 INFO - ##### 02:25:46 INFO - Running post-run listener: _resource_record_post_run 02:25:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 540000256; Read time: 0; Write time: 525948 02:25:46 INFO - TinderboxPrint: CPU usage
13.4% 02:25:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:25:46 INFO - TinderboxPrint: I/O write bytes / time
540,000,256 / 525,948 02:25:46 INFO - TinderboxPrint: CPU idle
8,219.5 (86.6%) 02:25:46 INFO - TinderboxPrint: CPU user
1,218.9 (12.8%) 02:25:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:25:46 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 253173760; Read time: 0; Write time: 324552 02:25:46 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 286826496; Read time: 0; Write time: 201396 02:25:47 INFO - Running post-run listener: _upload_blobber_files 02:25:47 INFO - Blob upload gear active. 02:25:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:25:47 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:25:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:25:47 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:25:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:48 INFO - (blobuploader) - INFO - Done attempting. 02:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:53 INFO - (blobuploader) - INFO - Done attempting. 02:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:53 INFO - (blobuploader) - INFO - Done attempting. 02:25:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:25:53 INFO - Return code: 0 02:25:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:25:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:25:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67db225565d40c04440ef38faba1f40100e2f3b35ce0372f6cc4af0bfdf1cf43234da9d74413a4771c4c9672ba2dcf8532c20eb738288574ef4c9a10ba22e065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8c0a7088493a691322c7a1b38124535ef06042680b30824fecc475ffe1af5743c76a7262fe80ede7fa8137cc8852f58c0a9d75c33f0d4bc1458f0afce7cd11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b4ffb07f67326ee167d285caf2b4c31b11e52d23e7cc028e2cce2dd3000d3b346ac86fcc9d7f4281d275b6be08d82830bb62222c27c06db76b63cb5f655fe2"} 02:25:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:25:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:25:53 INFO - Contents: 02:25:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67db225565d40c04440ef38faba1f40100e2f3b35ce0372f6cc4af0bfdf1cf43234da9d74413a4771c4c9672ba2dcf8532c20eb738288574ef4c9a10ba22e065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8c0a7088493a691322c7a1b38124535ef06042680b30824fecc475ffe1af5743c76a7262fe80ede7fa8137cc8852f58c0a9d75c33f0d4bc1458f0afce7cd11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b4ffb07f67326ee167d285caf2b4c31b11e52d23e7cc028e2cce2dd3000d3b346ac86fcc9d7f4281d275b6be08d82830bb62222c27c06db76b63cb5f655fe2"} 02:25:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:25:53 INFO - Copying logs to upload dir... 02:25:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:25:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.254117 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 02:25:53.496181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:25:53.499879) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 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/Mozilla-Inbound/sha512/67db225565d40c04440ef38faba1f40100e2f3b35ce0372f6cc4af0bfdf1cf43234da9d74413a4771c4c9672ba2dcf8532c20eb738288574ef4c9a10ba22e065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8c0a7088493a691322c7a1b38124535ef06042680b30824fecc475ffe1af5743c76a7262fe80ede7fa8137cc8852f58c0a9d75c33f0d4bc1458f0afce7cd11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b4ffb07f67326ee167d285caf2b4c31b11e52d23e7cc028e2cce2dd3000d3b346ac86fcc9d7f4281d275b6be08d82830bb62222c27c06db76b63cb5f655fe2"} build_url:https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/bUbzUU3KTc6SrfqJh9G09Q/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/Mozilla-Inbound/sha512/67db225565d40c04440ef38faba1f40100e2f3b35ce0372f6cc4af0bfdf1cf43234da9d74413a4771c4c9672ba2dcf8532c20eb738288574ef4c9a10ba22e065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef8c0a7088493a691322c7a1b38124535ef06042680b30824fecc475ffe1af5743c76a7262fe80ede7fa8137cc8852f58c0a9d75c33f0d4bc1458f0afce7cd11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59b4ffb07f67326ee167d285caf2b4c31b11e52d23e7cc028e2cce2dd3000d3b346ac86fcc9d7f4281d275b6be08d82830bb62222c27c06db76b63cb5f655fe2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:25:53.524569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:25:53.524915) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463648717.724193-1060119084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:25:53.608338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:25:53.608665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:25:53.608962) ========= ========= Total master_lag: 0.16 =========