builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1469563978.11 results: success (0) buildid: 20160726103058 builduid: 40d15738e33a473c946c9ec0fc7c402c revision: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.107765) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.108320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.108651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.128883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.129263) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 13:12:58-- 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% 88.2M=0s 2016-07-26 13:12:58 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.257923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.258255) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013931 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.308526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:58.308880) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac --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=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 13:12:58,480 truncating revision to first 12 chars 2016-07-26 13:12:58,481 Setting DEBUG logging. 2016-07-26 13:12:58,481 attempt 1/10 2016-07-26 13:12:58,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ceb63dec9267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 13:12:58,820 unpacking tar archive at: mozilla-central-ceb63dec9267/testing/mozharness/ program finished with exit code 0 elapsedTime=0.726825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:59.049684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:59.050165) ========= script_repo_revision: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:59.050614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:59.050882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 13:12:59.063903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-26 13:12:59.064175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:12:59 INFO - MultiFileLogger online at 20160726 13:12:59 in /builds/slave/test 13:12:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:12:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:12:59 INFO - {'append_to_log': False, 13:12:59 INFO - 'base_work_dir': '/builds/slave/test', 13:12:59 INFO - 'blob_upload_branch': 'Firefox', 13:12:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:12:59 INFO - 'branch': 'Firefox', 13:12:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:12:59 INFO - 'config_files': ('talos/linux_config.py',), 13:12:59 INFO - 'default_actions': ('clobber', 13:12:59 INFO - 'read-buildbot-config', 13:12:59 INFO - 'download-and-extract', 13:12:59 INFO - 'populate-webroot', 13:12:59 INFO - 'create-virtualenv', 13:12:59 INFO - 'install', 13:12:59 INFO - 'run-tests'), 13:12:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:12:59 INFO - 'download_minidump_stackwalk': True, 13:12:59 INFO - 'download_symbols': 'ondemand', 13:12:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:12:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:12:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:12:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:12:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:12:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:12:59 INFO - 'installer_path': 'installer.exe', 13:12:59 INFO - 'log_level': 'info', 13:12:59 INFO - 'log_name': 'talos', 13:12:59 INFO - 'log_to_console': True, 13:12:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:12:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:12:59 INFO - 'opt_config_files': (), 13:12:59 INFO - 'pip_index': False, 13:12:59 INFO - 'sps_profile': False, 13:12:59 INFO - 'sps_profile_interval': 0, 13:12:59 INFO - 'suite': 'dromaeojs', 13:12:59 INFO - 'system_bits': '32', 13:12:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:12:59 INFO - 'title': 'talos-linux64-ix-012', 13:12:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:12:59 INFO - 'use_talos_json': True, 13:12:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:12:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:12:59 INFO - 'work_dir': 'build'} 13:12:59 INFO - [mozharness: 2016-07-26 20:12:59.329772Z] Running clobber step. 13:12:59 INFO - Running pre-action listener: _resource_record_pre_action 13:12:59 INFO - Running main action method: clobber 13:12:59 INFO - rmtree: /builds/slave/test/build 13:12:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:12:59 INFO - Running post-action listener: _resource_record_post_action 13:12:59 INFO - [mozharness: 2016-07-26 20:12:59.799381Z] Finished clobber step (success) 13:12:59 INFO - [mozharness: 2016-07-26 20:12:59.799482Z] Running read-buildbot-config step. 13:12:59 INFO - Running pre-action listener: _resource_record_pre_action 13:12:59 INFO - Running main action method: read_buildbot_config 13:12:59 INFO - Using buildbot properties: 13:12:59 INFO - { 13:12:59 INFO - "project": "", 13:12:59 INFO - "product": "firefox", 13:12:59 INFO - "script_repo_revision": "production", 13:12:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:12:59 INFO - "repository": "", 13:12:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:12:59 INFO - "buildid": "20160726103058", 13:12:59 INFO - "pgo_build": "True", 13:12:59 INFO - "basedir": "/builds/slave/test", 13:12:59 INFO - "buildnumber": 807, 13:12:59 INFO - "slavename": "talos-linux64-ix-012", 13:12:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:12:59 INFO - "platform": "ubuntu64_hw", 13:12:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:12:59 INFO - "branch": "mozilla-central", 13:12:59 INFO - "repo_path": "mozilla-central", 13:12:59 INFO - "revision": "ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac", 13:12:59 INFO - "stage_platform": "linux64-pgo", 13:12:59 INFO - "builduid": "40d15738e33a473c946c9ec0fc7c402c", 13:12:59 INFO - "slavebuilddir": "test" 13:12:59 INFO - } 13:12:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:12:59 INFO - Running post-action listener: _resource_record_post_action 13:12:59 INFO - [mozharness: 2016-07-26 20:12:59.801946Z] Finished read-buildbot-config step (success) 13:12:59 INFO - [mozharness: 2016-07-26 20:12:59.802036Z] Running download-and-extract step. 13:12:59 INFO - Running pre-action listener: _resource_record_pre_action 13:12:59 INFO - Running main action method: download_and_extract 13:12:59 INFO - mkdir: /builds/slave/test/build/tests 13:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:59 INFO - https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:13:04 INFO - Downloaded 1361 bytes. 13:13:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:13:04 INFO - Using the following test package requirements: 13:13:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:13:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:13:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:13:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'jsshell-linux-x86_64.zip'], 13:13:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:13:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:13:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:13:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:13:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:13:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:13:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:13:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:04 INFO - https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:13:05 INFO - Downloaded 24313426 bytes. 13:13:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:13:06 INFO - Return code: 0 13:13:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:06 INFO - https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:13:21 INFO - Downloaded 24313426 bytes. 13:13:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:13:23 INFO - Return code: 0 13:13: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')]} 13:13:23 INFO - https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:13:24 INFO - Downloaded 14413725 bytes. 13:13:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:13:24 INFO - Return code: 0 13:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:24 INFO - https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:13:25 INFO - Downloaded 60924593 bytes. 13:13:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:25 INFO - mkdir: /builds/slave/test/properties 13:13:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:13:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:13:25 INFO - Contents: 13:13:25 INFO - build_url:https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:13:26 INFO - Running post-action listener: _resource_record_post_action 13:13:26 INFO - Running post-action listener: set_extra_try_arguments 13:13:26 INFO - [mozharness: 2016-07-26 20:13:26.321422Z] Finished download-and-extract step (success) 13:13:26 INFO - [mozharness: 2016-07-26 20:13:26.321754Z] Running populate-webroot step. 13:13:26 INFO - Running pre-action listener: _resource_record_pre_action 13:13:26 INFO - Running main action method: populate_webroot 13:13:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:13:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:13:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:13:26 INFO - '--tppagecycles', 13:13:26 INFO - '7'], 13:13:26 INFO - 'tests': ['tsvgm']}}, 13:13:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:13:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:13:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:13:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:13:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:13:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['damp', 'tps']}, 13:13:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'tests': ['damp', 'tps']}, 13:13:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['dromaeo_dom']}, 13:13:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:13:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['basic_compositor_video']}, 13:13:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:13:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'other-e10s': {'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['a11yr', 13:13:26 INFO - 'ts_paint', 13:13:26 INFO - 'tpaint', 13:13:26 INFO - 'sessionrestore', 13:13:26 INFO - 'sessionrestore_no_auto_restore', 13:13:26 INFO - 'tabpaint']}, 13:13:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['tsvgx', 13:13:26 INFO - 'tsvgr_opacity', 13:13:26 INFO - 'tart', 13:13:26 INFO - 'tscrollx', 13:13:26 INFO - 'cart']}, 13:13:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:13:26 INFO - 'tsvgr_opacity', 13:13:26 INFO - 'tart', 13:13:26 INFO - 'tscrollx', 13:13:26 INFO - 'cart']}, 13:13:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'talos_options': ['--disable-e10s'], 13:13:26 INFO - 'tests': ['tp5o']}, 13:13:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'tests': ['tp5o']}, 13:13:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'talos_options': ['--disable-e10s', 13:13:26 INFO - '--xperf_path', 13:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:26 INFO - 'tests': ['tp5n']}, 13:13:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:13:26 INFO - 'talos_options': ['--xperf_path', 13:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:13:26 INFO - 'tests': ['tp5n']}}, 13:13:26 INFO - 'talos.zip': {'path': '', 13:13:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:13:26 INFO - Running post-action listener: _resource_record_post_action 13:13:26 INFO - [mozharness: 2016-07-26 20:13:26.341009Z] Finished populate-webroot step (success) 13:13:26 INFO - [mozharness: 2016-07-26 20:13:26.341099Z] Running create-virtualenv step. 13:13:26 INFO - Running pre-action listener: _resource_record_pre_action 13:13:26 INFO - Running main action method: create_virtualenv 13:13:26 INFO - Creating virtualenv /builds/slave/test/build/venv 13:13:26 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 13:13:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:13:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:13:26 INFO - Using real prefix '/usr' 13:13:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:13:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:13:28 INFO - Installing pip.................done. 13:13:28 INFO - Return code: 0 13:13:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:13:28 INFO - Using env: {'DISPLAY': ':0', 13:13:28 INFO - 'HOME': '/home/cltbld', 13:13:28 INFO - 'LANG': 'en_US.UTF-8', 13:13:28 INFO - 'LANGUAGE': 'en_US:en', 13:13:28 INFO - 'LOGNAME': 'cltbld', 13:13:28 INFO - 'MAIL': '/var/mail/cltbld', 13:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:28 INFO - 'MOZ_NO_REMOTE': '1', 13:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:28 INFO - 'NO_EM_RESTART': '1', 13:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:28 INFO - 'PWD': '/builds/slave/test', 13:13:28 INFO - 'SHELL': '/bin/bash', 13:13:28 INFO - 'SHLVL': '1', 13:13:28 INFO - 'TERM': 'linux', 13:13:28 INFO - 'TMOUT': '86400', 13:13:28 INFO - 'USER': 'cltbld', 13:13:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:28 INFO - '_': '/tools/buildbot/bin/python'} 13:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:29 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 13:13:29 INFO - Cleaning up... 13:13:29 INFO - Return code: 0 13:13:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:13:29 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')]} 13:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:29 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')]} 13:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:29 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:29 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 13:13:29 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 13:13:29 INFO - Using env: {'DISPLAY': ':0', 13:13:29 INFO - 'HOME': '/home/cltbld', 13:13:29 INFO - 'LANG': 'en_US.UTF-8', 13:13:29 INFO - 'LANGUAGE': 'en_US:en', 13:13:29 INFO - 'LOGNAME': 'cltbld', 13:13:29 INFO - 'MAIL': '/var/mail/cltbld', 13:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:29 INFO - 'MOZ_NO_REMOTE': '1', 13:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:29 INFO - 'NO_EM_RESTART': '1', 13:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:29 INFO - 'PWD': '/builds/slave/test', 13:13:29 INFO - 'SHELL': '/bin/bash', 13:13:29 INFO - 'SHLVL': '1', 13:13:29 INFO - 'TERM': 'linux', 13:13:29 INFO - 'TMOUT': '86400', 13:13:29 INFO - 'USER': 'cltbld', 13:13:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:29 INFO - '_': '/tools/buildbot/bin/python'} 13:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:29 INFO - Downloading/unpacking psutil>=3.1.1 13:13:29 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 13:13:29 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 13:13:29 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 13:13:29 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 13:13:29 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 13:13:29 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 13:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:31 INFO - Installing collected packages: psutil 13:13:31 INFO - Running setup.py install for psutil 13:13:31 INFO - building 'psutil._psutil_linux' extension 13:13:31 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 13:13:31 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 13:13:31 INFO - building 'psutil._psutil_posix' extension 13:13:31 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 13:13:31 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 13:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:31 INFO - Successfully installed psutil 13:13:31 INFO - Cleaning up... 13:13:31 INFO - Return code: 0 13:13:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:13:31 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')]} 13:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:31 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')]} 13:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:31 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:31 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 13:13:31 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 13:13:31 INFO - Using env: {'DISPLAY': ':0', 13:13:31 INFO - 'HOME': '/home/cltbld', 13:13:31 INFO - 'LANG': 'en_US.UTF-8', 13:13:31 INFO - 'LANGUAGE': 'en_US:en', 13:13:31 INFO - 'LOGNAME': 'cltbld', 13:13:31 INFO - 'MAIL': '/var/mail/cltbld', 13:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:31 INFO - 'MOZ_NO_REMOTE': '1', 13:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:31 INFO - 'NO_EM_RESTART': '1', 13:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:31 INFO - 'PWD': '/builds/slave/test', 13:13:31 INFO - 'SHELL': '/bin/bash', 13:13:31 INFO - 'SHLVL': '1', 13:13:31 INFO - 'TERM': 'linux', 13:13:31 INFO - 'TMOUT': '86400', 13:13:31 INFO - 'USER': 'cltbld', 13:13:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:31 INFO - '_': '/tools/buildbot/bin/python'} 13:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:13:34 INFO - Installing collected packages: mozsystemmonitor 13:13:34 INFO - Running setup.py install for mozsystemmonitor 13:13:34 INFO - Successfully installed mozsystemmonitor 13:13:34 INFO - Cleaning up... 13:13:34 INFO - Return code: 0 13:13:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:13: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 jsonschema==2.5.1 13:13:34 INFO - Using env: {'DISPLAY': ':0', 13:13:34 INFO - 'HOME': '/home/cltbld', 13:13:34 INFO - 'LANG': 'en_US.UTF-8', 13:13:34 INFO - 'LANGUAGE': 'en_US:en', 13:13:34 INFO - 'LOGNAME': 'cltbld', 13:13:34 INFO - 'MAIL': '/var/mail/cltbld', 13:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:34 INFO - 'MOZ_NO_REMOTE': '1', 13:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:34 INFO - 'NO_EM_RESTART': '1', 13:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:34 INFO - 'PWD': '/builds/slave/test', 13:13:34 INFO - 'SHELL': '/bin/bash', 13:13:34 INFO - 'SHLVL': '1', 13:13:34 INFO - 'TERM': 'linux', 13:13:34 INFO - 'TMOUT': '86400', 13:13:34 INFO - 'USER': 'cltbld', 13:13:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:34 INFO - '_': '/tools/buildbot/bin/python'} 13:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:13:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:13:36 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 13:13:36 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 13:13:36 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 13:13:36 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 13:13:36 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 13:13:36 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 13:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:13:36 INFO - warning: no files found matching '*.txt' 13:13:36 INFO - no previously-included directories found matching 'build' 13:13:36 INFO - no previously-included directories found matching 'dist' 13:13:36 INFO - no previously-included directories found matching '.git*' 13:13:36 INFO - Installing collected packages: jsonschema, functools32 13:13:36 INFO - Running setup.py install for functools32 13:13:36 INFO - warning: no files found matching '*.txt' 13:13:36 INFO - no previously-included directories found matching 'build' 13:13:36 INFO - no previously-included directories found matching 'dist' 13:13:36 INFO - no previously-included directories found matching '.git*' 13:13:36 INFO - Successfully installed jsonschema functools32 13:13:36 INFO - Cleaning up... 13:13:36 INFO - Return code: 0 13:13:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:36 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:36 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:13:36 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 functools32==3.2.3-2 13:13:36 INFO - Using env: {'DISPLAY': ':0', 13:13:36 INFO - 'HOME': '/home/cltbld', 13:13:36 INFO - 'LANG': 'en_US.UTF-8', 13:13:36 INFO - 'LANGUAGE': 'en_US:en', 13:13:36 INFO - 'LOGNAME': 'cltbld', 13:13:36 INFO - 'MAIL': '/var/mail/cltbld', 13:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:36 INFO - 'MOZ_NO_REMOTE': '1', 13:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:36 INFO - 'NO_EM_RESTART': '1', 13:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:36 INFO - 'PWD': '/builds/slave/test', 13:13:36 INFO - 'SHELL': '/bin/bash', 13:13:36 INFO - 'SHLVL': '1', 13:13:36 INFO - 'TERM': 'linux', 13:13:36 INFO - 'TMOUT': '86400', 13:13:36 INFO - 'USER': 'cltbld', 13:13:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:36 INFO - '_': '/tools/buildbot/bin/python'} 13:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:13:37 INFO - Cleaning up... 13:13:37 INFO - Return code: 0 13:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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', '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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:13: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 blobuploader==1.2.4 13:13:37 INFO - Using env: {'DISPLAY': ':0', 13:13:37 INFO - 'HOME': '/home/cltbld', 13:13:37 INFO - 'LANG': 'en_US.UTF-8', 13:13:37 INFO - 'LANGUAGE': 'en_US:en', 13:13:37 INFO - 'LOGNAME': 'cltbld', 13:13:37 INFO - 'MAIL': '/var/mail/cltbld', 13:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:37 INFO - 'MOZ_NO_REMOTE': '1', 13:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:37 INFO - 'NO_EM_RESTART': '1', 13:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:37 INFO - 'PWD': '/builds/slave/test', 13:13:37 INFO - 'SHELL': '/bin/bash', 13:13:37 INFO - 'SHLVL': '1', 13:13:37 INFO - 'TERM': 'linux', 13:13:37 INFO - 'TMOUT': '86400', 13:13:37 INFO - 'USER': 'cltbld', 13:13:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:37 INFO - '_': '/tools/buildbot/bin/python'} 13:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:37 INFO - Downloading/unpacking blobuploader==1.2.4 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13: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 13:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:13:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 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 13:13:39 INFO - Downloading docopt-0.6.1.tar.gz 13:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:13:40 INFO - Running setup.py install for blobuploader 13:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:13:40 INFO - Running setup.py install for requests 13:13:40 INFO - Running setup.py install for docopt 13:13:40 INFO - Successfully installed blobuploader requests docopt 13:13:40 INFO - Cleaning up... 13:13:40 INFO - Return code: 0 13:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:40 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')]} 13:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:40 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')]} 13:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:40 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:40 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 13:13:40 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 13:13:40 INFO - Using env: {'DISPLAY': ':0', 13:13:40 INFO - 'HOME': '/home/cltbld', 13:13:40 INFO - 'LANG': 'en_US.UTF-8', 13:13:40 INFO - 'LANGUAGE': 'en_US:en', 13:13:40 INFO - 'LOGNAME': 'cltbld', 13:13:40 INFO - 'MAIL': '/var/mail/cltbld', 13:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:40 INFO - 'MOZ_NO_REMOTE': '1', 13:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:40 INFO - 'NO_EM_RESTART': '1', 13:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:40 INFO - 'PWD': '/builds/slave/test', 13:13:40 INFO - 'SHELL': '/bin/bash', 13:13:40 INFO - 'SHLVL': '1', 13:13:40 INFO - 'TERM': 'linux', 13:13:40 INFO - 'TMOUT': '86400', 13:13:40 INFO - 'USER': 'cltbld', 13:13:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:40 INFO - '_': '/tools/buildbot/bin/python'} 13:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:40 INFO - Running setup.py (path:/tmp/pip-czWhd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:40 INFO - Running setup.py (path:/tmp/pip-TTJn18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:41 INFO - Running setup.py (path:/tmp/pip-xWTrje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:41 INFO - Running setup.py (path:/tmp/pip-wGbRmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:41 INFO - Running setup.py (path:/tmp/pip-C0ACeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:41 INFO - Running setup.py (path:/tmp/pip-yz2do5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:41 INFO - Running setup.py (path:/tmp/pip-yVGsH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:41 INFO - Running setup.py (path:/tmp/pip-6u8Nth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:41 INFO - Running setup.py (path:/tmp/pip-P9tezH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:41 INFO - Running setup.py (path:/tmp/pip-xfSCZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:41 INFO - Running setup.py (path:/tmp/pip-knSlGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:41 INFO - Running setup.py (path:/tmp/pip-MS2xR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:41 INFO - Running setup.py (path:/tmp/pip-QOHky5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:41 INFO - Running setup.py (path:/tmp/pip-DOLj02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:41 INFO - Running setup.py (path:/tmp/pip-24yL_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:41 INFO - Running setup.py (path:/tmp/pip-jqTwp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:42 INFO - Running setup.py (path:/tmp/pip-KJXGth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:13:42 INFO - Running setup.py install for manifestparser 13:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Running setup.py install for mozcrash 13:13:42 INFO - Running setup.py install for mozdebug 13:13:42 INFO - Running setup.py install for mozdevice 13:13:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Running setup.py install for mozfile 13:13:42 INFO - Running setup.py install for mozhttpd 13:13:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Running setup.py install for mozinfo 13:13:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Running setup.py install for mozInstall 13:13:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:13:42 INFO - Running setup.py install for mozleak 13:13:42 INFO - Running setup.py install for mozlog 13:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Running setup.py install for moznetwork 13:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Running setup.py install for mozprocess 13:13:43 INFO - Running setup.py install for mozprofile 13:13:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Running setup.py install for mozrunner 13:13:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Running setup.py install for mozscreenshot 13:13:43 INFO - Running setup.py install for moztest 13:13:43 INFO - Running setup.py install for mozversion 13:13:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:13:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:13:43 INFO - Cleaning up... 13:13:43 INFO - Return code: 0 13:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13: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')]} 13:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:43 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:43 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 13:13:43 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 13:13:43 INFO - Using env: {'DISPLAY': ':0', 13:13:43 INFO - 'HOME': '/home/cltbld', 13:13:43 INFO - 'LANG': 'en_US.UTF-8', 13:13:43 INFO - 'LANGUAGE': 'en_US:en', 13:13:43 INFO - 'LOGNAME': 'cltbld', 13:13:43 INFO - 'MAIL': '/var/mail/cltbld', 13:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:43 INFO - 'MOZ_NO_REMOTE': '1', 13:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:43 INFO - 'NO_EM_RESTART': '1', 13:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:43 INFO - 'PWD': '/builds/slave/test', 13:13:43 INFO - 'SHELL': '/bin/bash', 13:13:43 INFO - 'SHLVL': '1', 13:13:43 INFO - 'TERM': 'linux', 13:13:43 INFO - 'TMOUT': '86400', 13:13:43 INFO - 'USER': 'cltbld', 13:13:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:43 INFO - '_': '/tools/buildbot/bin/python'} 13:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:44 INFO - Running setup.py (path:/tmp/pip-ABBQvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:44 INFO - Running setup.py (path:/tmp/pip-_Px44A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:44 INFO - Running setup.py (path:/tmp/pip-tjVF14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:44 INFO - Running setup.py (path:/tmp/pip-8VzHzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:44 INFO - Running setup.py (path:/tmp/pip-Ph2WUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:44 INFO - Running setup.py (path:/tmp/pip-gQqJjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:44 INFO - Running setup.py (path:/tmp/pip-Fbx9sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:44 INFO - Running setup.py (path:/tmp/pip-iHYxAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:44 INFO - Running setup.py (path:/tmp/pip-VkpxpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:44 INFO - Running setup.py (path:/tmp/pip-xPd7fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:44 INFO - Running setup.py (path:/tmp/pip-ouiryw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:44 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:44 INFO - Running setup.py (path:/tmp/pip-nW2ZLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:44 INFO - Running setup.py (path:/tmp/pip-ji5Mt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:45 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)) 13:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:45 INFO - Running setup.py (path:/tmp/pip-R1uUJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:45 INFO - Running setup.py (path:/tmp/pip-nL7Q0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:45 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)) 13:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:45 INFO - Running setup.py (path:/tmp/pip-WL7Hyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:45 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)) 13:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:45 INFO - Running setup.py (path:/tmp/pip-mfCnOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:45 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)) 13:13:45 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)) 13:13:45 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)) 13:13:45 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)) 13:13:45 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)) 13:13:45 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)) 13:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:13:45 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 13:13:45 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 13:13:45 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 13:13:45 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 13:13:45 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 13:13:45 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 13:13:47 INFO - Downloading blessings-1.6.tar.gz 13:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:13:47 INFO - Installing collected packages: blessings 13:13:47 INFO - Running setup.py install for blessings 13:13:47 INFO - Successfully installed blessings 13:13:47 INFO - Cleaning up... 13:13:47 INFO - Return code: 0 13:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:47 INFO - Reading from file tmpfile_stdout 13:13:47 INFO - Current package versions: 13:13:47 INFO - argparse == 1.2.1 13:13:47 INFO - blessings == 1.6 13:13:47 INFO - blobuploader == 1.2.4 13:13:47 INFO - docopt == 0.6.1 13:13:47 INFO - functools32 == 3.2.3-2 13:13:47 INFO - jsonschema == 2.5.1 13:13:47 INFO - manifestparser == 1.1 13:13:47 INFO - mozInstall == 1.12 13:13:47 INFO - mozcrash == 0.17 13:13:47 INFO - mozdebug == 0.1 13:13:47 INFO - mozdevice == 0.48 13:13:47 INFO - mozfile == 1.2 13:13:47 INFO - mozhttpd == 0.7 13:13:47 INFO - mozinfo == 0.9 13:13:47 INFO - mozleak == 0.1 13:13:47 INFO - mozlog == 3.3 13:13:47 INFO - moznetwork == 0.27 13:13:47 INFO - mozprocess == 0.23 13:13:47 INFO - mozprofile == 0.28 13:13:47 INFO - mozrunner == 6.12 13:13:47 INFO - mozscreenshot == 0.1 13:13:47 INFO - mozsystemmonitor == 0.3 13:13:47 INFO - moztest == 0.7 13:13:47 INFO - mozversion == 1.4 13:13:47 INFO - psutil == 3.1.1 13:13:47 INFO - requests == 1.2.3 13:13:47 INFO - wsgiref == 0.1.2 13:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:47 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:47 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 13:13:47 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 13:13:47 INFO - Using env: {'DISPLAY': ':0', 13:13:47 INFO - 'HOME': '/home/cltbld', 13:13:47 INFO - 'LANG': 'en_US.UTF-8', 13:13:47 INFO - 'LANGUAGE': 'en_US:en', 13:13:47 INFO - 'LOGNAME': 'cltbld', 13:13:47 INFO - 'MAIL': '/var/mail/cltbld', 13:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:47 INFO - 'MOZ_NO_REMOTE': '1', 13:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:47 INFO - 'NO_EM_RESTART': '1', 13:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:47 INFO - 'PWD': '/builds/slave/test', 13:13:47 INFO - 'SHELL': '/bin/bash', 13:13:47 INFO - 'SHLVL': '1', 13:13:47 INFO - 'TERM': 'linux', 13:13:47 INFO - 'TMOUT': '86400', 13:13:47 INFO - 'USER': 'cltbld', 13:13:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:47 INFO - '_': '/tools/buildbot/bin/python'} 13:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 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)) 13:13:47 INFO - Cleaning up... 13:13:47 INFO - Return code: 0 13:13:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:13:47 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 0x2a83030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d44180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', '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 13:13:47 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 13:13:47 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 13:13:47 INFO - Using env: {'DISPLAY': ':0', 13:13:47 INFO - 'HOME': '/home/cltbld', 13:13:47 INFO - 'LANG': 'en_US.UTF-8', 13:13:47 INFO - 'LANGUAGE': 'en_US:en', 13:13:47 INFO - 'LOGNAME': 'cltbld', 13:13:47 INFO - 'MAIL': '/var/mail/cltbld', 13:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:47 INFO - 'MOZ_NO_REMOTE': '1', 13:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:47 INFO - 'NO_EM_RESTART': '1', 13:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:47 INFO - 'PWD': '/builds/slave/test', 13:13:47 INFO - 'SHELL': '/bin/bash', 13:13:47 INFO - 'SHLVL': '1', 13:13:47 INFO - 'TERM': 'linux', 13:13:47 INFO - 'TMOUT': '86400', 13:13:47 INFO - 'USER': 'cltbld', 13:13:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:47 INFO - '_': '/tools/buildbot/bin/python'} 13:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:13:48 INFO - Cleaning up... 13:13:48 INFO - Return code: 0 13:13:48 INFO - Running post-action listener: _resource_record_post_action 13:13:48 INFO - Running post-action listener: _start_resource_monitoring 13:13:48 INFO - Starting resource monitoring. 13:13:48 INFO - [mozharness: 2016-07-26 20:13:48.195959Z] Finished create-virtualenv step (success) 13:13:48 INFO - [mozharness: 2016-07-26 20:13:48.196449Z] Running install step. 13:13:48 INFO - Running pre-action listener: _resource_record_pre_action 13:13:48 INFO - Running main action method: install 13:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:48 INFO - Reading from file tmpfile_stdout 13:13:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:13:48 INFO - Reading from file tmpfile_stdout 13:13:48 INFO - Output received: 13:13:48 INFO - Usage: mozinstall [options] installer 13:13:48 INFO - Options: 13:13:48 INFO - -h, --help show this help message and exit 13:13:48 INFO - -d DEST, --destination=DEST 13:13:48 INFO - Directory to install application into. [default: 13:13:48 INFO - "/builds/slave/test"] 13:13:48 INFO - --app=APP Application being installed. [default: firefox] 13:13:48 INFO - mkdir: /builds/slave/test/build/application 13:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:14:05 INFO - Reading from file tmpfile_stdout 13:14:05 INFO - Output received: 13:14:05 INFO - /builds/slave/test/build/application/firefox/firefox 13:14:05 INFO - Running post-action listener: _resource_record_post_action 13:14:05 INFO - [mozharness: 2016-07-26 20:14:05.722108Z] Finished install step (success) 13:14:05 INFO - [mozharness: 2016-07-26 20:14:05.722386Z] Running run-tests step. 13:14:05 INFO - Running pre-action listener: _resource_record_pre_action 13:14:05 INFO - Running main action method: run_tests 13:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:14:05 INFO - Python 2.7.3 13:14:05 INFO - Return code: 0 13:14:05 INFO - grabbing minidump binary from tooltool 13:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:05 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 0x2d423b0>, '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 0x2d432b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d43740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:14:05 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 13:14:05 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 13:14:05 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 13:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:14:05 INFO - Return code: 0 13:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:14:05 INFO - Using env: {'DISPLAY': ':0', 13:14:05 INFO - 'HOME': '/home/cltbld', 13:14:05 INFO - 'LANG': 'en_US.UTF-8', 13:14:05 INFO - 'LANGUAGE': 'en_US:en', 13:14:05 INFO - 'LOGNAME': 'cltbld', 13:14:05 INFO - 'MAIL': '/var/mail/cltbld', 13:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:05 INFO - 'MOZ_NO_REMOTE': '1', 13:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:05 INFO - 'NO_EM_RESTART': '1', 13:14:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:05 INFO - 'PWD': '/builds/slave/test', 13:14:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:14:05 INFO - 'SHELL': '/bin/bash', 13:14:05 INFO - 'SHLVL': '1', 13:14:05 INFO - 'TERM': 'linux', 13:14:05 INFO - 'TMOUT': '86400', 13:14:05 INFO - 'USER': 'cltbld', 13:14:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554', 13:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:05 INFO - '_': '/tools/buildbot/bin/python'} 13:14:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:14:05 INFO - mozversion application_buildid: 20160726103058 13:14:05 INFO - mozversion application_changeset: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac 13:14:05 INFO - mozversion application_display_name: Nightly 13:14:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:14:05 INFO - mozversion application_name: Firefox 13:14:05 INFO - mozversion application_remotingname: firefox 13:14:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:14:05 INFO - mozversion application_vendor: Mozilla 13:14:05 INFO - mozversion application_version: 50.0a1 13:14:05 INFO - mozversion platform_buildid: 20160726103058 13:14:05 INFO - mozversion platform_changeset: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac 13:14:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:14:05 INFO - mozversion platform_version: 50.0a1 13:14:05 INFO - using testdate: 1469564045 13:14:05 INFO - actual date: 1469564045 13:14:05 INFO - starting webserver on 'localhost:49591' 13:14:05 INFO - SUITE-START | Running 2 tests 13:14:05 INFO - TEST-START | dromaeo_css 13:14:05 INFO - operating with platform_type : linux_ 13:14:05 INFO - Initialising browser for dromaeo_css test... 13:14:05 INFO - TEST-INFO | started process 32247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiy3qoS/profile http://localhost:49591/getInfo.html) 13:14:08 INFO - PROCESS | 32247 | JavaScript error: , line 0: uncaught exception: undefined 13:14:09 INFO - PROCESS | 32247 | __metrics Screen width/height:1600/1200 13:14:09 INFO - PROCESS | 32247 | colorDepth:24 13:14:09 INFO - PROCESS | 32247 | Browser inner width/height: 1024/697 13:14:09 INFO - PROCESS | 32247 | __metrics 13:14:10 INFO - PROCESS | 32247 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:14:10 INFO - PROCESS | 32247 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:10 INFO - TEST-INFO | 32247: exit 0 13:14:10 INFO - Browser initialized. 13:14:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:14:10 INFO - TEST-INFO | started process 32328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiy3qoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:22 INFO - PROCESS | 32328 | RSS: Main: 157720576 13:14:22 INFO - PROCESS | 32328 | 13:15:14 INFO - PROCESS | 32328 | 1469564114405 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] 13:17:22 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49591/tests/dromaeo/cssquery-ext.html) 13:17:23 INFO - PROCESS | 32328 | RSS: Main: 284606464 13:17:23 INFO - PROCESS | 32328 | 13:20:26 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-ext.html (next: http://localhost:49591/tests/dromaeo/cssquery-jquery.html) 13:20:26 INFO - PROCESS | 32328 | RSS: Main: 249303040 13:20:26 INFO - PROCESS | 32328 | 13:23:28 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49591/tests/dromaeo/cssquery-mootools.html) 13:23:29 INFO - PROCESS | 32328 | RSS: Main: 185405440 13:23:29 INFO - PROCESS | 32328 | 13:26:31 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49591/tests/dromaeo/cssquery-prototype.html) 13:26:31 INFO - PROCESS | 32328 | RSS: Main: 214503424 13:26:31 INFO - PROCESS | 32328 | 13:29:34 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49591/tests/dromaeo/cssquery-yui.html) 13:29:34 INFO - PROCESS | 32328 | RSS: Main: 186949632 13:29:34 INFO - PROCESS | 32328 | 13:32:37 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:49591/tests/dromaeo/cssquery-yui.html (next: http://localhost:49591/tests/dromaeo/cssquery-dojo.html) 13:32:38 INFO - PROCESS | 32328 | RSS: Main: 281714688 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | __start_tp_report 13:32:38 INFO - PROCESS | 32328 | _x_x_mozilla_page_load 13:32:38 INFO - PROCESS | 32328 | _x_x_mozilla_page_load_details 13:32:38 INFO - PROCESS | 32328 | |i|pagename|runs| 13:32:38 INFO - PROCESS | 32328 | |0;dojo.html;3093.969060309397;3099.0392978176765;3100.4729196036687;3136.9372612547736;3163.3515129398475;5359.785608575662;5401.378841433237;5466.863328416786;5549.056660367737;5556.444355564441;5477.1510415885605;5520.475554822286;5547.11246200608;5590.301212348457;5602.047651899176;4945.604351651859;4985.900281994376;5038.773255203525;5051.873703157414;5157.277981082651;5064.113780088488;5128.820491282806;5147.202183661539;5160.974195129019;5167.534921857032;4832.782524786393;4871.8782030449165;4945.2582112683385;4987.027529631723;5018.459731910958;4977.303177555145;4981.352424184869;5000.074986127578;5012.022655582163;5058.215976523645;5014.799408023675;5041.72270525121;5057.696538207682;5062.670926389773;5075;5303.761330740126;5487.807926722586;5546.500814926676;5558.360788509292;5631.943680563183;5956.106584012389;5959.10613407988;5963.642181469082;5997.610155339889;6010.128531362928;6019.909701354483;6049.48579370754;6049.78825741097;6070.089486577004;6074.9392506075255;5344.278522399465;5413.133898576249;5451.945480545183;5463.31708536433;5534.612577119644;6035.30593981689;6035.486983606354;6038.909416358758;6045.123457098696;6045.909311360333;5802.680852553066;5802.767889284381;5806.390329015392;5806.68063256525;5810.5061069809535;5665.291838520185;5800.651960882361;5855.121731740273;5858.091995740582;5886.352501224862;5846.590738648254;5899.46904778572;5905.43898329658;5957.4042595740075;5964.880702385928;5860.062390017577;5906;5918.763249470059;5922.2597175353085;5927.822165334961;4379.167958087953;4409.22838503267;4413.801378937956;4462.843800467033;4473.5526447355005;3986.940195897064;4024.2957482440456;4027.516697996259;4029.0531725044593;4029.194161167778;5473.75368108436;5519.089350257243;5566.666000040011;5573.164025396223;5574.386817450078;5881.852953676107;5886.911696324559;5914.556408269397;5917.5857689961285;5930.970345148246;5489.011977843947;5526.143447765603;5536.280283563192;5538.169274608841;5548.361938377057;4918.926216106761;4959.107360675041;5022.673526220784;5035.1188542005;5071.0872043032605;6010.66941318223;6025.517958563304;6041.093835924647;6060.33336333003;6085.08723691441;5803.8549036274435;5835.533157347402;5848.4151584842875;5855.824325270249;5857.238558987305;5854.970725146347;5960.046392577166;6018.187544681412;6021.7591296347655;6024.096385542029;5727.599068065196;5779.450952159538;5787.797427090031;5831.35855055935;5842.415758424294;5871.823845284648;5880.8235752927485;5883.94116058834;5884.08796636522;5886.882262354815;5585.301837270341;5630.88738225225;5728.914066288926;5759.1649210865025;5764.221830052889;5644.88710225785;5706.144078388275;5707.372189059283;5711.942880571307;5757.309122905111;5550.58370622213;5627.099664053731;5637.408072152365;5647.181158732043;5648.124540696199;5639.802606908738;5730.484256416942;5731.684757338387;5742.885142297214;5805.071188609802;5639.689817060101;5682.204491371129;5682.715864206856;5725.656460612377;5733.967885780433 13:32:38 INFO - PROCESS | 32328 | |1;ext.html;566.2610293566894;606.8755905039466;619.3651507205115;626.811956413076;633.3508154142007;29956.400871982547;30544;32949.34101317978;32989.34021319575;33170.66829331706;41492.792536037276;42039.57960420395;42522;47478.287825682644;47544.52455475444;8826.86759698605;8956.910430895705;8959.37284390093;8966.820663586725;8971;8844.955775221115;8902.510361930092;8934.597943092544;8938.016818149998;8938.374313798036;8959.865602015974;8996.235319997808;8997.640094396216;8999.595018224163;9001.954990225073;8906.866397004018;8953.328500362433;8964.50695211763;8969.641214351419;8971.685990990283;8747.650093996233;8803.691870784492;8830.823383532357;8831;8835.690750823755;41711.79144104291;41744.37383439251;41778.582214177775;42079.1584168318;42175.36736948948;3346;3357.093584732109;3564.518789963348;3622.855085796565;3855.51806024247;32366.35267294641;32728.345433091206;32784;32825.34349313001;33465.665343346496;4313.84901528445;4335.393044973706;4387.9561204387865;4405.757683327416;4457.64338852891;354150;355834;356326.2183689091;356657;356756;52280.738596307536;52704.47295527072;52726.47273527215;52771;52840;49992.750036249585;53755.46244537583;61049.5580176788;61133.38866611277;61154.38845611576;15649;16106.114163720873;16124.677506449805;16140.35438582467;16157.757633635505;11997.64007079789;12117.575884843987;12122.515099396102;12129.939350303192;12141.514339426323;15078.698426031637;16523.66952660964;17089.31642734277;17223.3971810986;17228;6109.7861574844665;6179.16581261533;6214.627122372672;6271.519306784687;6340.587861788969;938.1556599060764;1002.1081237698454;1010.2170817616259;1030.443560477334;1074.6023971130576;32910.10310307802;32978.83510582432;33118.3376332472;33510.832445837616;33658.66341336604;1056;1106.8948449897248;1124.252372172496;1136.181948996721;1158.8319693644373;16870.746938795928;17164.656706865793;17386.21762020687;17391.47825565235;17514.562135946704;492596;816138;831637;832020;833781;58508.4149158503;59008;59101.40898591045;59262.407375925686;59298.11052834211;1316.8485624153154;1335.5659410691565;1337.505123104438;1342.5636668082716;1351.074513957942;31197.612871302266;33300.500492492145;33511.49732753962;33734.662653373154;33913.66086339105;51380;51594.48405516047;51816.481835182676;51832.48167518427;51895.74052129715;346091;346318.36816318164;346900;347408;348330;24408.755912440647;27882.860585697752;46020;46636.53363466322;46937;46793;50813.491865080876;50973.235401468264;51364.89080873596;51530;42484.362734559625;42656.5734342665;43510.34734479048;44070;45446.77276613596;42689.57310426856;42873.571264286955;43393.915152120186;44187.337189941536;44938.77530612326;43021.35467967921;43700;44310.55689443064;44721.552784471736;44754;36419.27161456809;38745.80627096847;38792.22415551617;39645.60354396534;40286;28512.714872851837;28593.571096433985;28722.425551488435;28883;29253.268668283465 13:32:38 INFO - PROCESS | 32328 | |2;jquery.html;366.1304402045143;383.8137483056322;396.1759540156475;397.64808144791857;411.5267442441194;14371.856281437182;17349.653006939854;19084.61830763384;19838.603227935433;19889.60220795583;19396;19409.223631054778;20070.397888063344;20207.393778186677;20224.797752022474;5746.59773815832;5920.88158236835;5931.584789064767;5942.762289508414;5943.257092863392;4213.115245798371;5815.534757219433;5867.2372591563035;6192.78325258616;6479.384458476437;6452.935470645304;6509.153810004693;6509.674516274191;6510.08858759774;6514.511411644122;6391.488680905516;6461.483081353504;6462.095306657072;6486.416222539994;6599.241087274977;5617.101263797814;5776.075827867563;5829.679367634779;5839.562032847553;5853.560982926255;23053.19313824008;23310.41723956898;23555.29334119979;23596.528069438515;23785.762142378702;2247.662850572427;2262.739784924738;2269.965950510744;2301.860305354914;2934.207763903734;14361.425542978268;14469.34887930035;14775;14865.108093514424;14974.925125374413;1837.338558119076;1882.1342182596022;1951.7072439134101;1956.2370675436591;2023.3424137155337;83309.58345208236;83692.58153709193;85398.57300713456;86132;86299.99999999937;10423.218258630633;10606;10881.782364352668;11000.449977501094;11146.832797508045;15150.848491515164;15190.392384304725;15213.61965950838;15232.238388080552;15252.771208431883;8168.978877640295;8241.423100382915;8325.708600198965;8413.873791893126;8417;7890.763277101696;7907.209279072047;7949.364050875916;8100.594970251464;8116.6347514362;6601.768938087144;6742.123523941857;6783.38949494538;6789.456843452512;6794.184697836193;1836.4123480486116;1855.8151368663578;1881.2380985700813;1909.9427017189507;1940.7671079470272;886.264400547544;966.7389804752678;1014.5130337437923;1015.8120747661707;1047.9738006549896;20640.277590284568;20717.68923466149;20788.792112078685;20849.270275540588;21031.474213144793;954.4798085043668;974.639383428122;1017.8980405462696;1025.5692609104194;1049.8267785815408;10893.564257429614;11534.94232528832;11656.358900260397;11670.299782013106;11720.941395293139;439359;443578;453695;456339;456641;78938;83306.16693832984;83330.58334708409;84124;84476;1012.3217444312328;1051.5951358726945;1070.2133931560297;1083.788661211072;1084.3981590217504;17146.828531715022;17684.823151768833;18424.723629145843;18463.630727385647;18667.71998420052;26195.476090478463;37676.623233768405;42619.786901065294;42642.78678606587;44154.11691766211;53770;54391;54394;55858.44141558695;60635.09047364381;7532.811679708051;7624.199459056941;7777.883331749915;7926.365890728613;7981.8403631928195;10967.451627418437;12608.74782504363;12858.871411285767;13028.869711303145;13177.341132943506;11418.657440276806;11444.484998174936;11487.597934072268;11490.77018459643;11617.477213525242;11072.169587281147;11158.49786759614;11345.773084538429;11525.481353339288;11742.236754610924;10427.635032773816;11657;11825.704357391134;11869.287842729464;11941.283522988648;7166.498345115792;7731.92268077312;7797.532148071134;7853.607319633881;8117.756467305991;11326.357678136788;11493.367864767519;11657.125715571536;11791.410429478663;11799 13:32:38 INFO - PROCESS | 32328 | |3;mootools.html;1292.68975445893;1418.8510206428325;1490.8956373053886;1555.26125090582;1722.035660030383;8389.958050209749;8727.825443491134;8793.208611224989;8996.550172491381;9000.369974101815;8845.91154088459;8905.243054340388;8906.153915378045;8921.55392230389;8956.46261224327;2306.2850516339945;2331.3122628824453;2332.825038122139;2334.11303704592;2340.1458467659354;2354.0348457132577;2369.656399822025;2435.8782060896974;2437.5368679950843;2445.254197469771;2369.5024044950583;2373.086361750721;2399.1123284384803;2403.531311394279;2406.2901444073955;2283.1666441748807;2292.6331786914097;2296.334063121693;2312.8612283262974;2323.639835825433;2299.1378233162563;2299.1952816514254;2299.678045073691;2305.3660243433023;2311.133325003124;8852.690155844515;8894.86657700135;8906.421082629673;8949.507777072258;8956.328275379308;5255.211718242256;5375.274337964403;5386.165144402624;5395.298611180521;5398.379186393537;3397.2695870387984;3414.726821854246;3462.3594634992355;3481.634428385034;3486.442169252907;1049.6588608702202;1067.4982758103756;2157.6547752359547;2260.559190957764;2273.3180045986137;12383.876161238453;12393.504259829686;12432.067594930417;12499;12543.937280313632;4369;4478.261086920622;4575.130725162208;4578.9771051144535;4664.533546645308;9927.255455840841;9930.602775888883;9930.950345248228;9936;9938.10557049869;5432.565394768409;5432.6468779529205;5438.428964958702;5440.891182176334;5445.482679145475;4388.978055109704;4913.164761990471;5026.572741317029;5066.949330506648;5087.821926232638;3809.7333186676665;3862.613738626115;3925.2738243425056;3962.405639154092;3991.6806655467494;1100.6092837042895;1108.7560736637927;1109.5506319940437;1109.9944500277447;1117.5082963496036;794.5232860283899;837.9287760540301;886.5877367024235;939.572494514994;997.8175861604022;5781.94218057814;5856.970715146397;5988.921994041028;6095.512359011268;6245.313015568284;430.3802524364905;444.03201021772844;446.82127149140604;1026.645807196516;1061.2836335473523;3701.833417496219;3809.104860357814;3874.1089549403796;3943.132510847609;3974.7813870237414;11075.280106793032;11515.309081454972;11517.25137866036;11524.308541487537;11530.423478826193;11297.435128243555;11326.093912486982;11406.144539159597;11505.654830355103;11518.136139789549;8362.58187090643;8402.663893444194;8511.914880851236;8523.360747943929;8526.232639062515;5615.691136987505;5695.231143795535;5713.800016999385;5730.226419433323;5932.13983972313;9496.857547136937;10531.368117912949;10539.15686745074;10564.313319634199;10663.306885052447;9933.056359645821;10109;10147.289689721649;10199.643012494527;10221.744456388353;7217.422606191597;7280.381167600602;7705.460617756703;7913.723019694283;8093.231143041402;8465.788355291166;8830;8837.558122093998;8845.55772211374;8851.778705532413;7764.495307804975;7950.16523265072;8043.517388956681;8084.474509156886;8319.126491718282;7734.806629834299;7771.184025677222;7932.6033698313695;7970.880436793337;8003.159668234752;6969.965150174216;7073.681684324115;7073.787786366417;7073.929260707327;7077.964610176916;5135.87160320995;5345.33183352081;5365.731713414391;5381.977424289373;5475.159184814011;5040.672356296829;5069.847904562869;5082.847514574569;5090.592752579711;5120.846374608767 13:32:38 INFO - PROCESS | 32328 | |4;prototype.html;319.2370235138019;332.3403044955762;337.73319077928437;338.90341252742974;341.6327447993408;5098;5196.896062078766;5281.234221037952;5288.788448462057;5303.382468347153;5187.533122019017;5192.55863251624;5214;5231.764570594323;5240.213967904816;4095.75425474471;4097.242010228118;4105.30209864323;4110.219058378913;4137.5448700643055;4021.6380525752675;4123.3196522573735;4130.256553820311;4150.398192262121;4153.958460415402;4077.5718549552316;4083.734557253769;4085.142120154771;4099.713020088595;4100.482821356102;4075.816588253536;4076.408920706481;4076.408920706511;4077.9601201693677;4125;3467.9479807802904;3604.53141091659;3624.855005799765;3627.782333060025;3630.2739452109686;5084.949150508522;5106.64253502255;5112.105381558213;5120.463860841733;5122.9764243123755;4687.929681054787;4695.577398034159;4698.224792909165;4706.517447004183;4706.576408123286;5268.420473747885;5434.755436005389;5475.563374298439;5476.26070480488;5489.670619762827;3985.326163011542;3995.760254384746;3997.6601988830985;3997.900052498682;3999.960000400017;5678.687672178028;5716.228309178249;5719.342275638355;5729.939961107167;5738.569607279429;3974.9863784734707;4068.8575899843363;4071.91856162881;4094.5700701426517;4095.9795201023803;4101;4101.420952933142;4113.650339721157;4117.1765646870745;4117.75293482392;4668.11305851887;4674.158651442773;4681.180793361148;4688.97655511727;4702.764861756898;5285.2600635911;5490.450954904558;5528.585356098229;5542.75057622408;5584.553235741131;1328.5217321764158;1374.9725005499834;1378.6070969773566;1386.646405166676;1400.5798260521804;951.9476428796482;956.5886668732512;972.7665360313474;977.1840513171582;981.5877331520778;5269.103122875762;5282.181261904411;5285.867853303621;5287.154055351125;5287.154055351202;5565;5575.191597218381;5579.963313390584;5587.552995760329;5589.524890384281;5073.670211436245;5263.55252305619;5267.604929630293;5283.867903302448;5367.470270972754;3000.804947678394;3018.743406810446;3027.2431892026993;3030.2878823476467;3050.816950982948;5870.853228669317;5874.94125058744;5894.381089985575;5907.438793314628;5915.349311575723;5561.833145005657;5746.482816546531;5747.971260143756;5778.306603207642;5779.653220806765;5839.678817665069;5843.860447212753;5852.951466986606;5853.946289667901;5878.2064421304285;5401.918971215514;5639.830805075854;5647.548196144381;5675.716214189357;5681.659100453986;5597.608167428241;5609.298837645294;5610.120609595831;5630.88738225225;5638.605297629127;5836.80345529174;5871.119332100219;5876.676782776988;5915.881682366243;5916.26046744157;3878.612138786099;3940.4680368149934;3948.2824971137647;3981.56202817684;3983.2232714620372;5441.911617676401;5624.943750562442;5672.631278966854;5698.886022279614;5704.429557044263;5460.91808622863;5511.090670039399;5574.581906356958;5590.748416321357;5597.496225339739;5535.169724541351;5554.916676249779;5580.1629755537;5585.525230355465;5603.691796951207;5284.603654725834;5506.981208476284;5519.586031047607;5524.392316845064;5531.8893622128135;5630.380658127521;5638.548916086621;5644.923516683335;5648.293963254593;5653.236813030353;5418.45815418455;5531.902134804523;5584.720763961867;5595.272614560081;5604.719764011702 13:32:38 INFO - PROCESS | 32328 | |5;yui.html;712.1489819665499;713.7858642407276;727.4834867244256;756.0511557994715;782.3897360059156;14917.104973701573;16510.17449127542;16519.752203716955;16536.58658533537;16543.00741955482;13471.528496502624;13631.318434078306;13747.58757237282;13856.515021974234;15270;795.5862951265353;811.8822770698246;814.0922870998824;815.8776183572452;817.7015389382863;815.4780940198278;819.848328059308;821.8849361089452;822.0382152881114;822.2640736540792;861.1130535548364;861.9655213791441;864.256739204287;865.0398058155442;865.2040123086744;862.611824678897;863.1497974495118;863.3179787967498;863.4517081653164;864.9524276164808;625.3933684326196;625.837282306599;626.786892456567;626.9780557680459;627.0249761620678;13549.119307244997;13925.30373481332;13926.721465570632;13998.860011399858;14018;13277;13368.799468007988;13757.79363309551;13775.931120344434;13817.240051797147;12661.30362830044;12678.80981785274;13155.868441315655;13476.797848032287;13880.652983675387;4449.644028477714;4593.494715581283;4629.467611224719;4665.5567721066445;4741.193997020515;73646.63176684083;73751.26248737551;74006;74230;75082.62458687671;11542.19204655666;11703.686775599048;11737.061035117342;11878.643640690792;11927.403629818475;21075.68386474204;21086.156553737987;21214.681779773317;21387.14451421957;21434.464138396666;8731.25784308341;8747.256483198998;8808.779780505538;8881.73354799357;8900.866487002571;4945.876353091202;4961.131801934719;4990.700557966461;5088.262201980766;5170.71561064145;3408.3183363327435;3518.630543792916;3539.0444579963264;3543.4153364694535;3551.058969373118;602.7498588085983;609.2810483629271;615.387689249191;637.0507943164652;648.2577448821073;612.8192183305936;620.4632992461578;685.9931400686029;722.9638518074075;741.6217728958162;9384.170056997365;10029.899701003042;10033.43478717182;10895.945520272347;10902.563897444172;672.9528932974645;736.5654263984275;749.8462815122887;769.9499532530367;796.3430170109567;4552.385427967249;4989.3264409305;4995.500449955048;5027.195648696191;5083.74581270935;103953;111426;113060;120590.39704801595;120768;56526.43473565212;96623.51688241513;100975.49512252392;103070.96929030764;105129;87913.56043219742;89639;90257;90971;93287.0671293292;9295.67465138717;9424.790844318715;9685.9031409685;9866;9939.403635781877;51635.96728065493;51710.74144629253;52138;52677.9464410702;53032;67613.32386676071;68605.65697171482;74856;75652;76016.23983760092;13646.795298070736;13780.793288100485;13819.79270310926;14100.506482273071;14150.43398264058;14628.780568291271;14977;15020.474283400028;15211.619709507351;16086.517404477885;14014.402112974603;14098.718025639635;14161.929190353982;14422.927885360506;14728.189949552878;14158;14525;14689.265536722907;14721.631959201106;14831.703365932837;14176.362063707364;14382.137071775727;14538.200398978157;14700.117992920032;15015.699686006437;11131.489912493367;11403.486843092247;11518.769624607294;11707.941460292644;11901.583444579399;10765.838512422477;11106.278091924;11244.325340479598;11649.650510484698;12250.509979600716 13:32:38 INFO - PROCESS | 32328 | __end_tp_report 13:32:38 INFO - PROCESS | 32328 | __start_cc_report 13:32:38 INFO - PROCESS | 32328 | _x_x_mozilla_cycle_collect,1091 13:32:38 INFO - PROCESS | 32328 | __end_cc_report 13:32:38 INFO - PROCESS | 32328 | __startTimestamp1469565158194__endTimestamp 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | ------- Summary: start ------- 13:32:38 INFO - PROCESS | 32328 | Number of tests: 6 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#0] dojo.html Cycles:165 Average:5459.14 Median:5644.89 stddev:629.13 (11.1%) stddev-sans-first:603.08 13:32:38 INFO - PROCESS | 32328 | Values: 3094.0 3099.0 3100.5 3136.9 3163.4 5359.8 5401.4 5466.9 5549.1 5556.4 5477.2 5520.5 5547.1 5590.3 5602.0 4945.6 4985.9 5038.8 5051.9 5157.3 5064.1 5128.8 5147.2 5161.0 5167.5 4832.8 4871.9 4945.3 4987.0 5018.5 4977.3 4981.4 5000.1 5012.0 5058.2 5014.8 5041.7 5057.7 5062.7 5075.0 5303.8 5487.8 5546.5 5558.4 5631.9 5956.1 5959.1 5963.6 5997.6 6010.1 6019.9 6049.5 6049.8 6070.1 6074.9 5344.3 5413.1 5451.9 5463.3 5534.6 6035.3 6035.5 6038.9 6045.1 6045.9 5802.7 5802.8 5806.4 5806.7 5810.5 5665.3 5800.7 5855.1 5858.1 5886.4 5846.6 5899.5 5905.4 5957.4 5964.9 5860.1 5906.0 5918.8 5922.3 5927.8 4379.2 4409.2 4413.8 4462.8 4473.6 3986.9 4024.3 4027.5 4029.1 4029.2 5473.8 5519.1 5566.7 5573.2 5574.4 5881.9 5886.9 5914.6 5917.6 5931.0 5489.0 5526.1 5536.3 5538.2 5548.4 4918.9 4959.1 5022.7 5035.1 5071.1 6010.7 6025.5 6041.1 6060.3 6085.1 5803.9 5835.5 5848.4 5855.8 5857.2 5855.0 5960.0 6018.2 6021.8 6024.1 5727.6 5779.5 5787.8 5831.4 5842.4 5871.8 5880.8 5883.9 5884.1 5886.9 5585.3 5630.9 5728.9 5759.2 5764.2 5644.9 5706.1 5707.4 5711.9 5757.3 5550.6 5627.1 5637.4 5647.2 5648.1 5639.8 5730.5 5731.7 5742.9 5805.1 5639.7 5682.2 5682.7 5725.7 5734.0 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#1] ext.html Cycles:180 Average:64297.25 Median:42673.07 stddev:142774.04 (334.6%) stddev-sans-first:143094.37 13:32:38 INFO - PROCESS | 32328 | Values: 566.3 606.9 619.4 626.8 633.4 29956.4 30544.0 32949.3 32989.3 33170.7 41492.8 42039.6 42522.0 47478.3 47544.5 8826.9 8956.9 8959.4 8966.8 8971.0 8845.0 8902.5 8934.6 8938.0 8938.4 8959.9 8996.2 8997.6 8999.6 9002.0 8906.9 8953.3 8964.5 8969.6 8971.7 8747.7 8803.7 8830.8 8831.0 8835.7 41711.8 41744.4 41778.6 42079.2 42175.4 3346.0 3357.1 3564.5 3622.9 3855.5 32366.4 32728.3 32784.0 32825.3 33465.7 4313.8 4335.4 4388.0 4405.8 4457.6 354150.0 355834.0 356326.2 356657.0 356756.0 52280.7 52704.5 52726.5 52771.0 52840.0 49992.8 53755.5 61049.6 61133.4 61154.4 15649.0 16106.1 16124.7 16140.4 16157.8 11997.6 12117.6 12122.5 12129.9 12141.5 15078.7 16523.7 17089.3 17223.4 17228.0 6109.8 6179.2 6214.6 6271.5 6340.6 938.2 1002.1 1010.2 1030.4 1074.6 32910.1 32978.8 33118.3 33510.8 33658.7 1056.0 1106.9 1124.3 1136.2 1158.8 16870.7 17164.7 17386.2 17391.5 17514.6 492596.0 816138.0 831637.0 832020.0 833781.0 58508.4 59008.0 59101.4 59262.4 59298.1 1316.8 1335.6 1337.5 1342.6 1351.1 31197.6 33300.5 33511.5 33734.7 33913.7 51380.0 51594.5 51816.5 51832.5 51895.7 346091.0 346318.4 346900.0 347408.0 348330.0 24408.8 27882.9 46020.0 46636.5 46937.0 46793.0 50813.5 50973.2 51364.9 51530.0 42484.4 42656.6 43510.3 44070.0 45446.8 42689.6 42873.6 43393.9 44187.3 44938.8 43021.4 43700.0 44310.6 44721.6 44754.0 36419.3 38745.8 38792.2 39645.6 40286.0 28512.7 28593.6 28722.4 28883.0 29253.3 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#2] jquery.html Cycles:180 Average:27828.83 Median:23181.81 stddev:74231.28 (320.2%) stddev-sans-first:74410.88 13:32:38 INFO - PROCESS | 32328 | Values: 366.1 383.8 396.2 397.6 411.5 14371.9 17349.7 19084.6 19838.6 19889.6 19396.0 19409.2 20070.4 20207.4 20224.8 5746.6 5920.9 5931.6 5942.8 5943.3 4213.1 5815.5 5867.2 6192.8 6479.4 6452.9 6509.2 6509.7 6510.1 6514.5 6391.5 6461.5 6462.1 6486.4 6599.2 5617.1 5776.1 5829.7 5839.6 5853.6 23053.2 23310.4 23555.3 23596.5 23785.8 2247.7 2262.7 2270.0 2301.9 2934.2 14361.4 14469.3 14775.0 14865.1 14974.9 1837.3 1882.1 1951.7 1956.2 2023.3 83309.6 83692.6 85398.6 86132.0 86300.0 10423.2 10606.0 10881.8 11000.4 11146.8 15150.8 15190.4 15213.6 15232.2 15252.8 8169.0 8241.4 8325.7 8413.9 8417.0 7890.8 7907.2 7949.4 8100.6 8116.6 6601.8 6742.1 6783.4 6789.5 6794.2 1836.4 1855.8 1881.2 1909.9 1940.8 886.3 966.7 1014.5 1015.8 1048.0 20640.3 20717.7 20788.8 20849.3 21031.5 954.5 974.6 1017.9 1025.6 1049.8 10893.6 11534.9 11656.4 11670.3 11720.9 439359.0 443578.0 453695.0 456339.0 456641.0 78938.0 83306.2 83330.6 84124.0 84476.0 1012.3 1051.6 1070.2 1083.8 1084.4 17146.8 17684.8 18424.7 18463.6 18667.7 26195.5 37676.6 42619.8 42642.8 44154.1 53770.0 54391.0 54394.0 55858.4 60635.1 7532.8 7624.2 7777.9 7926.4 7981.8 10967.5 12608.7 12858.9 13028.9 13177.3 11418.7 11444.5 11487.6 11490.8 11617.5 11072.2 11158.5 11345.8 11525.5 11742.2 10427.6 11657.0 11825.7 11869.3 11941.3 7166.5 7731.9 7797.5 7853.6 8117.8 11326.4 11493.4 11657.1 11791.4 11799.0 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#3] mootools.html Cycles:180 Average:5872.92 Median:5033.62 stddev:3369.39 (66.9%) stddev-sans-first:3361.26 13:32:38 INFO - PROCESS | 32328 | Values: 1292.7 1418.9 1490.9 1555.3 1722.0 8390.0 8727.8 8793.2 8996.6 9000.4 8845.9 8905.2 8906.2 8921.6 8956.5 2306.3 2331.3 2332.8 2334.1 2340.1 2354.0 2369.7 2435.9 2437.5 2445.3 2369.5 2373.1 2399.1 2403.5 2406.3 2283.2 2292.6 2296.3 2312.9 2323.6 2299.1 2299.2 2299.7 2305.4 2311.1 8852.7 8894.9 8906.4 8949.5 8956.3 5255.2 5375.3 5386.2 5395.3 5398.4 3397.3 3414.7 3462.4 3481.6 3486.4 1049.7 1067.5 2157.7 2260.6 2273.3 12383.9 12393.5 12432.1 12499.0 12543.9 4369.0 4478.3 4575.1 4579.0 4664.5 9927.3 9930.6 9931.0 9936.0 9938.1 5432.6 5432.6 5438.4 5440.9 5445.5 4389.0 4913.2 5026.6 5066.9 5087.8 3809.7 3862.6 3925.3 3962.4 3991.7 1100.6 1108.8 1109.6 1110.0 1117.5 794.5 837.9 886.6 939.6 997.8 5781.9 5857.0 5988.9 6095.5 6245.3 430.4 444.0 446.8 1026.6 1061.3 3701.8 3809.1 3874.1 3943.1 3974.8 11075.3 11515.3 11517.3 11524.3 11530.4 11297.4 11326.1 11406.1 11505.7 11518.1 8362.6 8402.7 8511.9 8523.4 8526.2 5615.7 5695.2 5713.8 5730.2 5932.1 9496.9 10531.4 10539.2 10564.3 10663.3 9933.1 10109.0 10147.3 10199.6 10221.7 7217.4 7280.4 7705.5 7913.7 8093.2 8465.8 8830.0 8837.6 8845.6 8851.8 7764.5 7950.2 8043.5 8084.5 8319.1 7734.8 7771.2 7932.6 7970.9 8003.2 6970.0 7073.7 7073.8 7073.9 7078.0 5135.9 5345.3 5365.7 5382.0 5475.2 5040.7 5069.8 5082.8 5090.6 5120.8 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#4] prototype.html Cycles:180 Average:4652.22 Median:5284.93 stddev:1368.90 (25.9%) stddev-sans-first:1333.54 13:32:38 INFO - PROCESS | 32328 | Values: 319.2 332.3 337.7 338.9 341.6 5098.0 5196.9 5281.2 5288.8 5303.4 5187.5 5192.6 5214.0 5231.8 5240.2 4095.8 4097.2 4105.3 4110.2 4137.5 4021.6 4123.3 4130.3 4150.4 4154.0 4077.6 4083.7 4085.1 4099.7 4100.5 4075.8 4076.4 4076.4 4078.0 4125.0 3467.9 3604.5 3624.9 3627.8 3630.3 5084.9 5106.6 5112.1 5120.5 5123.0 4687.9 4695.6 4698.2 4706.5 4706.6 5268.4 5434.8 5475.6 5476.3 5489.7 3985.3 3995.8 3997.7 3997.9 4000.0 5678.7 5716.2 5719.3 5729.9 5738.6 3975.0 4068.9 4071.9 4094.6 4096.0 4101.0 4101.4 4113.7 4117.2 4117.8 4668.1 4674.2 4681.2 4689.0 4702.8 5285.3 5490.5 5528.6 5542.8 5584.6 1328.5 1375.0 1378.6 1386.6 1400.6 951.9 956.6 972.8 977.2 981.6 5269.1 5282.2 5285.9 5287.2 5287.2 5565.0 5575.2 5580.0 5587.6 5589.5 5073.7 5263.6 5267.6 5283.9 5367.5 3000.8 3018.7 3027.2 3030.3 3050.8 5870.9 5874.9 5894.4 5907.4 5915.3 5561.8 5746.5 5748.0 5778.3 5779.7 5839.7 5843.9 5853.0 5853.9 5878.2 5401.9 5639.8 5647.5 5675.7 5681.7 5597.6 5609.3 5610.1 5630.9 5638.6 5836.8 5871.1 5876.7 5915.9 5916.3 3878.6 3940.5 3948.3 3981.6 3983.2 5441.9 5624.9 5672.6 5698.9 5704.4 5460.9 5511.1 5574.6 5590.7 5597.5 5535.2 5554.9 5580.2 5585.5 5603.7 5284.6 5507.0 5519.6 5524.4 5531.9 5630.4 5638.5 5644.9 5648.3 5653.2 5418.5 5531.9 5584.7 5595.3 5604.7 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - PROCESS | 32328 | [#5] yui.html Cycles:180 Average:20795.45 Median:4647.51 stddev:29569.08 (636.2%) stddev-sans-first:29613.58 13:32:38 INFO - PROCESS | 32328 | Values: 712.1 713.8 727.5 756.1 782.4 14917.1 16510.2 16519.8 16536.6 16543.0 13471.5 13631.3 13747.6 13856.5 15270.0 795.6 811.9 814.1 815.9 817.7 815.5 819.8 821.9 822.0 822.3 861.1 862.0 864.3 865.0 865.2 862.6 863.1 863.3 863.5 865.0 625.4 625.8 626.8 627.0 627.0 13549.1 13925.3 13926.7 13998.9 14018.0 13277.0 13368.8 13757.8 13775.9 13817.2 12661.3 12678.8 13155.9 13476.8 13880.7 4449.6 4593.5 4629.5 4665.6 4741.2 73646.6 73751.3 74006.0 74230.0 75082.6 11542.2 11703.7 11737.1 11878.6 11927.4 21075.7 21086.2 21214.7 21387.1 21434.5 8731.3 8747.3 8808.8 8881.7 8900.9 4945.9 4961.1 4990.7 5088.3 5170.7 3408.3 3518.6 3539.0 3543.4 3551.1 602.7 609.3 615.4 637.1 648.3 612.8 620.5 686.0 723.0 741.6 9384.2 10029.9 10033.4 10895.9 10902.6 673.0 736.6 749.8 769.9 796.3 4552.4 4989.3 4995.5 5027.2 5083.7 103953.0 111426.0 113060.0 120590.4 120768.0 56526.4 96623.5 100975.5 103071.0 105129.0 87913.6 89639.0 90257.0 90971.0 93287.1 9295.7 9424.8 9685.9 9866.0 9939.4 51636.0 51710.7 52138.0 52677.9 53032.0 67613.3 68605.7 74856.0 75652.0 76016.2 13646.8 13780.8 13819.8 14100.5 14150.4 14628.8 14977.0 15020.5 15211.6 16086.5 14014.4 14098.7 14161.9 14422.9 14728.2 14158.0 14525.0 14689.3 14721.6 14831.7 14176.4 14382.1 14538.2 14700.1 15015.7 11131.5 11403.5 11518.8 11707.9 11901.6 10765.8 11106.3 11244.3 11649.7 12250.5 13:32:38 INFO - PROCESS | 32328 | -------- Summary: end -------- 13:32:38 INFO - PROCESS | 32328 | 13:32:38 INFO - TEST-INFO | 32328: exit 0 13:32:38 INFO - TEST-OK | dromaeo_css | took 1112970ms 13:32:38 INFO - TEST-START | kraken 13:32:38 INFO - operating with platform_type : linux_ 13:32:38 INFO - Initialising browser for kraken test... 13:32:38 INFO - TEST-INFO | started process 32528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEybTMH/profile http://localhost:49591/getInfo.html) 13:32:41 INFO - PROCESS | 32528 | JavaScript error: , line 0: uncaught exception: undefined 13:32:42 INFO - PROCESS | 32528 | __metrics Screen width/height:1600/1200 13:32:42 INFO - PROCESS | 32528 | colorDepth:24 13:32:42 INFO - PROCESS | 32528 | Browser inner width/height: 1024/697 13:32:42 INFO - PROCESS | 32528 | __metrics 13:32:42 INFO - PROCESS | 32528 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:32:42 INFO - PROCESS | 32528 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:32:43 INFO - TEST-INFO | 32528: exit 0 13:32:43 INFO - Browser initialized. 13:32:43 INFO - Running cycle 1/1 for kraken test... 13:32:43 INFO - TEST-INFO | started process 32609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEybTMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:55 INFO - PROCESS | 32609 | RSS: Main: 157659136 13:32:55 INFO - PROCESS | 32609 | 13:32:58 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49591/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:59 INFO - PROCESS | 32609 | RSS: Main: 214171648 13:32:59 INFO - PROCESS | 32609 | 13:33:01 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49591/tests/kraken/driver.html?testName=audio-dft) 13:33:02 INFO - PROCESS | 32609 | RSS: Main: 193581056 13:33:02 INFO - PROCESS | 32609 | 13:33:05 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49591/tests/kraken/driver.html?testName=audio-fft) 13:33:05 INFO - PROCESS | 32609 | RSS: Main: 269688832 13:33:05 INFO - PROCESS | 32609 | 13:33:08 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49591/tests/kraken/driver.html?testName=audio-oscillator) 13:33:08 INFO - PROCESS | 32609 | RSS: Main: 180547584 13:33:08 INFO - PROCESS | 32609 | 13:33:10 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:33:11 INFO - PROCESS | 32609 | RSS: Main: 185892864 13:33:11 INFO - PROCESS | 32609 | 13:33:14 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49591/tests/kraken/driver.html?testName=imaging-darkroom) 13:33:14 INFO - PROCESS | 32609 | RSS: Main: 219865088 13:33:14 INFO - PROCESS | 32609 | 13:33:18 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49591/tests/kraken/driver.html?testName=imaging-desaturate) 13:33:18 INFO - PROCESS | 32609 | RSS: Main: 220381184 13:33:18 INFO - PROCESS | 32609 | 13:33:21 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49591/tests/kraken/driver.html?testName=json-parse-financial) 13:33:22 INFO - PROCESS | 32609 | RSS: Main: 220516352 13:33:22 INFO - PROCESS | 32609 | 13:33:23 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:33:24 INFO - PROCESS | 32609 | RSS: Main: 185012224 13:33:24 INFO - PROCESS | 32609 | 13:33:26 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:33:26 INFO - PROCESS | 32609 | RSS: Main: 190472192 13:33:26 INFO - PROCESS | 32609 | 13:33:28 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:33:29 INFO - PROCESS | 32609 | RSS: Main: 195166208 13:33:29 INFO - PROCESS | 32609 | 13:33:32 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:33:32 INFO - PROCESS | 32609 | RSS: Main: 188715008 13:33:32 INFO - PROCESS | 32609 | 13:33:35 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:33:35 INFO - PROCESS | 32609 | RSS: Main: 194011136 13:33:35 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | Cycle 1(1): loaded http://localhost:49591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49591/tests/kraken/driver.html?testName=ai-astar) 13:33:37 INFO - PROCESS | 32609 | RSS: Main: 244416512 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | __start_tp_report 13:33:37 INFO - PROCESS | 32609 | _x_x_mozilla_page_load 13:33:37 INFO - PROCESS | 32609 | _x_x_mozilla_page_load_details 13:33:37 INFO - PROCESS | 32609 | |i|pagename|runs| 13:33:37 INFO - PROCESS | 32609 | |0;ai-astar;101;109;109;111;109;109;109;110;109;109 13:33:37 INFO - PROCESS | 32609 | |1;audio-beat-detection;140;116;118;180;115;117;148;115;151;122 13:33:37 INFO - PROCESS | 32609 | |2;audio-dft;161;160;160;162;160;160;161;161;160;160 13:33:37 INFO - PROCESS | 32609 | |3;audio-fft;74;75;75;113;76;75;75;75;104;76 13:33:37 INFO - PROCESS | 32609 | |4;audio-oscillator;85;84;116;84;85;84;130;83;84;138 13:33:37 INFO - PROCESS | 32609 | |5;imaging-gaussian-blur;116;116;116;117;116;116;116;117;116;116 13:33:37 INFO - PROCESS | 32609 | |6;imaging-darkroom;145;149;146;146;145;146;146;145;145;146 13:33:37 INFO - PROCESS | 32609 | |7;imaging-desaturate;94;96;96;94;95;95;95;95;96;95 13:33:37 INFO - PROCESS | 32609 | |8;json-parse-financial;54;52;54;53;53;52;53;53;52;60 13:33:37 INFO - PROCESS | 32609 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;63;63;62 13:33:37 INFO - PROCESS | 32609 | |10;stanford-crypto-aes;76;76;75;75;76;76;76;82;76;75 13:33:37 INFO - PROCESS | 32609 | |11;stanford-crypto-ccm;122;120;120;129;135;119;126;132;166;128 13:33:37 INFO - PROCESS | 32609 | |12;stanford-crypto-pbkdf2;158;155;155;160;158;154;157;155;153;154 13:33:37 INFO - PROCESS | 32609 | |13;stanford-crypto-sha256-iterative;64;63;65;62;65;63;62;63;62;61 13:33:37 INFO - PROCESS | 32609 | __end_tp_report 13:33:37 INFO - PROCESS | 32609 | __start_cc_report 13:33:37 INFO - PROCESS | 32609 | _x_x_mozilla_cycle_collect,1678 13:33:37 INFO - PROCESS | 32609 | __end_cc_report 13:33:37 INFO - PROCESS | 32609 | __startTimestamp1469565217787__endTimestamp 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | ------- Summary: start ------- 13:33:37 INFO - PROCESS | 32609 | Number of tests: 14 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:2.72 (2.5%) stddev-sans-first:0.71 13:33:37 INFO - PROCESS | 32609 | Values: 101.0 109.0 109.0 111.0 109.0 109.0 109.0 110.0 109.0 109.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:131.00 stddev:21.96 (16.8%) stddev-sans-first:23.11 13:33:37 INFO - PROCESS | 32609 | Values: 140.0 116.0 118.0 180.0 115.0 117.0 148.0 115.0 151.0 122.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 13:33:37 INFO - PROCESS | 32609 | Values: 161.0 160.0 160.0 162.0 160.0 160.0 161.0 161.0 160.0 160.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:14.24 (19.0%) stddev-sans-first:14.82 13:33:37 INFO - PROCESS | 32609 | Values: 74.0 75.0 75.0 113.0 76.0 75.0 75.0 75.0 104.0 76.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:84.00 stddev:21.83 (26.0%) stddev-sans-first:22.70 13:33:37 INFO - PROCESS | 32609 | Values: 85.0 84.0 116.0 84.0 85.0 84.0 130.0 83.0 84.0 138.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:33:37 INFO - PROCESS | 32609 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 13:33:37 INFO - PROCESS | 32609 | Values: 145.0 149.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 13:33:37 INFO - PROCESS | 32609 | Values: 94.0 96.0 96.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.37 (4.5%) stddev-sans-first:2.51 13:33:37 INFO - PROCESS | 32609 | Values: 54.0 52.0 54.0 53.0 53.0 52.0 53.0 53.0 52.0 60.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:33:37 INFO - PROCESS | 32609 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.06 (2.7%) stddev-sans-first:2.18 13:33:37 INFO - PROCESS | 32609 | Values: 76.0 76.0 75.0 75.0 76.0 76.0 76.0 82.0 76.0 75.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:128.50 stddev:13.86 (10.8%) stddev-sans-first:14.42 13:33:37 INFO - PROCESS | 32609 | Values: 122.0 120.0 120.0 129.0 135.0 119.0 126.0 132.0 166.0 128.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:2.23 (1.4%) stddev-sans-first:2.24 13:33:37 INFO - PROCESS | 32609 | Values: 158.0 155.0 155.0 160.0 158.0 154.0 157.0 155.0 153.0 154.0 13:33:37 INFO - PROCESS | 32609 | 13:33:37 INFO - PROCESS | 32609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 13:33:37 INFO - PROCESS | 32609 | Values: 64.0 63.0 65.0 62.0 65.0 63.0 62.0 63.0 62.0 61.0 13:33:37 INFO - PROCESS | 32609 | -------- Summary: end -------- 13:33:37 INFO - PROCESS | 32609 | 13:33:38 INFO - TEST-INFO | 32609: exit 0 13:33:38 INFO - TEST-OK | kraken | took 59843ms 13:33:38 INFO - SUITE-END | took 1172s 13:33:38 INFO - Completed test suite (00:19:32) 13:33:38 INFO - javascript benchmark 13:33:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.969060309397, 3099.0392978176765, 3100.4729196036687, 3136.9372612547736, 3163.3515129398475, 5359.785608575662, 5401.378841433237, 5466.863328416786, 5549.056660367737, 5556.444355564441, 5477.1510415885605, 5520.475554822286, 5547.11246200608, 5590.301212348457, 5602.047651899176, 4945.604351651859, 4985.900281994376, 5038.773255203525, 5051.873703157414, 5157.277981082651, 5064.113780088488, 5128.820491282806, 5147.202183661539, 5160.974195129019, 5167.534921857032, 4832.782524786393, 4871.8782030449165, 4945.2582112683385, 4987.027529631723, 5018.459731910958, 4977.303177555145, 4981.352424184869, 5000.074986127578, 5012.022655582163, 5058.215976523645, 5014.799408023675, 5041.72270525121, 5057.696538207682, 5062.670926389773, 5075.0, 5303.761330740126, 5487.807926722586, 5546.500814926676, 5558.360788509292, 5631.943680563183, 5956.106584012389, 5959.10613407988, 5963.642181469082, 5997.610155339889, 6010.128531362928, 6019.909701354483, 6049.48579370754, 6049.78825741097, 6070.089486577004, 6074.9392506075255, 5344.278522399465, 5413.133898576249, 5451.945480545183, 5463.31708536433, 5534.612577119644, 6035.30593981689, 6035.486983606354, 6038.909416358758, 6045.123457098696, 6045.909311360333, 5802.680852553066, 5802.767889284381, 5806.390329015392, 5806.68063256525, 5810.5061069809535, 5665.291838520185, 5800.651960882361, 5855.121731740273, 5858.091995740582, 5886.352501224862, 5846.590738648254, 5899.46904778572, 5905.43898329658, 5957.4042595740075, 5964.880702385928, 5860.062390017577, 5906.0, 5918.763249470059, 5922.2597175353085, 5927.822165334961, 4379.167958087953, 4409.22838503267, 4413.801378937956, 4462.843800467033, 4473.5526447355005, 3986.940195897064, 4024.2957482440456, 4027.516697996259, 4029.0531725044593, 4029.194161167778, 5473.75368108436, 5519.089350257243, 5566.666000040011, 5573.164025396223, 5574.386817450078, 5881.852953676107, 5886.911696324559, 5914.556408269397, 5917.5857689961285, 5930.970345148246, 5489.011977843947, 5526.143447765603, 5536.280283563192, 5538.169274608841, 5548.361938377057, 4918.926216106761, 4959.107360675041, 5022.673526220784, 5035.1188542005, 5071.0872043032605, 6010.66941318223, 6025.517958563304, 6041.093835924647, 6060.33336333003, 6085.08723691441, 5803.8549036274435, 5835.533157347402, 5848.4151584842875, 5855.824325270249, 5857.238558987305, 5854.970725146347, 5960.046392577166, 6018.187544681412, 6021.7591296347655, 6024.096385542029, 5727.599068065196, 5779.450952159538, 5787.797427090031, 5831.35855055935, 5842.415758424294, 5871.823845284648, 5880.8235752927485, 5883.94116058834, 5884.08796636522, 5886.882262354815, 5585.301837270341, 5630.88738225225, 5728.914066288926, 5759.1649210865025, 5764.221830052889, 5644.88710225785, 5706.144078388275, 5707.372189059283, 5711.942880571307, 5757.309122905111, 5550.58370622213, 5627.099664053731, 5637.408072152365, 5647.181158732043, 5648.124540696199, 5639.802606908738, 5730.484256416942, 5731.684757338387, 5742.885142297214, 5805.071188609802, 5639.689817060101, 5682.204491371129, 5682.715864206856, 5725.656460612377, 5733.967885780433], "value": 5415.584552571077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.2610293566894, 606.8755905039466, 619.3651507205115, 626.811956413076, 633.3508154142007, 29956.400871982547, 30544.0, 32949.34101317978, 32989.34021319575, 33170.66829331706, 41492.792536037276, 42039.57960420395, 42522.0, 47478.287825682644, 47544.52455475444, 8826.86759698605, 8956.910430895705, 8959.37284390093, 8966.820663586725, 8971.0, 8844.955775221115, 8902.510361930092, 8934.597943092544, 8938.016818149998, 8938.374313798036, 8959.865602015974, 8996.235319997808, 8997.640094396216, 8999.595018224163, 9001.954990225073, 8906.866397004018, 8953.328500362433, 8964.50695211763, 8969.641214351419, 8971.685990990283, 8747.650093996233, 8803.691870784492, 8830.823383532357, 8831.0, 8835.690750823755, 41711.79144104291, 41744.37383439251, 41778.582214177775, 42079.1584168318, 42175.36736948948, 3346.0, 3357.093584732109, 3564.518789963348, 3622.855085796565, 3855.51806024247, 32366.35267294641, 32728.345433091206, 32784.0, 32825.34349313001, 33465.665343346496, 4313.84901528445, 4335.393044973706, 4387.9561204387865, 4405.757683327416, 4457.64338852891, 354150.0, 355834.0, 356326.2183689091, 356657.0, 356756.0, 52280.738596307536, 52704.47295527072, 52726.47273527215, 52771.0, 52840.0, 49992.750036249585, 53755.46244537583, 61049.5580176788, 61133.38866611277, 61154.38845611576, 15649.0, 16106.114163720873, 16124.677506449805, 16140.35438582467, 16157.757633635505, 11997.64007079789, 12117.575884843987, 12122.515099396102, 12129.939350303192, 12141.514339426323, 15078.698426031637, 16523.66952660964, 17089.31642734277, 17223.3971810986, 17228.0, 6109.7861574844665, 6179.16581261533, 6214.627122372672, 6271.519306784687, 6340.587861788969, 938.1556599060764, 1002.1081237698454, 1010.2170817616259, 1030.443560477334, 1074.6023971130576, 32910.10310307802, 32978.83510582432, 33118.3376332472, 33510.832445837616, 33658.66341336604, 1056.0, 1106.8948449897248, 1124.252372172496, 1136.181948996721, 1158.8319693644373, 16870.746938795928, 17164.656706865793, 17386.21762020687, 17391.47825565235, 17514.562135946704, 492596.0, 816138.0, 831637.0, 832020.0, 833781.0, 58508.4149158503, 59008.0, 59101.40898591045, 59262.407375925686, 59298.11052834211, 1316.8485624153154, 1335.5659410691565, 1337.505123104438, 1342.5636668082716, 1351.074513957942, 31197.612871302266, 33300.500492492145, 33511.49732753962, 33734.662653373154, 33913.66086339105, 51380.0, 51594.48405516047, 51816.481835182676, 51832.48167518427, 51895.74052129715, 346091.0, 346318.36816318164, 346900.0, 347408.0, 348330.0, 24408.755912440647, 27882.860585697752, 46020.0, 46636.53363466322, 46937.0, 46793.0, 50813.491865080876, 50973.235401468264, 51364.89080873596, 51530.0, 42484.362734559625, 42656.5734342665, 43510.34734479048, 44070.0, 45446.77276613596, 42689.57310426856, 42873.571264286955, 43393.915152120186, 44187.337189941536, 44938.77530612326, 43021.35467967921, 43700.0, 44310.55689443064, 44721.552784471736, 44754.0, 36419.27161456809, 38745.80627096847, 38792.22415551617, 39645.60354396534, 40286.0, 28512.714872851837, 28593.571096433985, 28722.425551488435, 28883.0, 29253.268668283465], "value": 20177.988229292852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.1304402045143, 383.8137483056322, 396.1759540156475, 397.64808144791857, 411.5267442441194, 14371.856281437182, 17349.653006939854, 19084.61830763384, 19838.603227935433, 19889.60220795583, 19396.0, 19409.223631054778, 20070.397888063344, 20207.393778186677, 20224.797752022474, 5746.59773815832, 5920.88158236835, 5931.584789064767, 5942.762289508414, 5943.257092863392, 4213.115245798371, 5815.534757219433, 5867.2372591563035, 6192.78325258616, 6479.384458476437, 6452.935470645304, 6509.153810004693, 6509.674516274191, 6510.08858759774, 6514.511411644122, 6391.488680905516, 6461.483081353504, 6462.095306657072, 6486.416222539994, 6599.241087274977, 5617.101263797814, 5776.075827867563, 5829.679367634779, 5839.562032847553, 5853.560982926255, 23053.19313824008, 23310.41723956898, 23555.29334119979, 23596.528069438515, 23785.762142378702, 2247.662850572427, 2262.739784924738, 2269.965950510744, 2301.860305354914, 2934.207763903734, 14361.425542978268, 14469.34887930035, 14775.0, 14865.108093514424, 14974.925125374413, 1837.338558119076, 1882.1342182596022, 1951.7072439134101, 1956.2370675436591, 2023.3424137155337, 83309.58345208236, 83692.58153709193, 85398.57300713456, 86132.0, 86299.99999999937, 10423.218258630633, 10606.0, 10881.782364352668, 11000.449977501094, 11146.832797508045, 15150.848491515164, 15190.392384304725, 15213.61965950838, 15232.238388080552, 15252.771208431883, 8168.978877640295, 8241.423100382915, 8325.708600198965, 8413.873791893126, 8417.0, 7890.763277101696, 7907.209279072047, 7949.364050875916, 8100.594970251464, 8116.6347514362, 6601.768938087144, 6742.123523941857, 6783.38949494538, 6789.456843452512, 6794.184697836193, 1836.4123480486116, 1855.8151368663578, 1881.2380985700813, 1909.9427017189507, 1940.7671079470272, 886.264400547544, 966.7389804752678, 1014.5130337437923, 1015.8120747661707, 1047.9738006549896, 20640.277590284568, 20717.68923466149, 20788.792112078685, 20849.270275540588, 21031.474213144793, 954.4798085043668, 974.639383428122, 1017.8980405462696, 1025.5692609104194, 1049.8267785815408, 10893.564257429614, 11534.94232528832, 11656.358900260397, 11670.299782013106, 11720.941395293139, 439359.0, 443578.0, 453695.0, 456339.0, 456641.0, 78938.0, 83306.16693832984, 83330.58334708409, 84124.0, 84476.0, 1012.3217444312328, 1051.5951358726945, 1070.2133931560297, 1083.788661211072, 1084.3981590217504, 17146.828531715022, 17684.823151768833, 18424.723629145843, 18463.630727385647, 18667.71998420052, 26195.476090478463, 37676.623233768405, 42619.786901065294, 42642.78678606587, 44154.11691766211, 53770.0, 54391.0, 54394.0, 55858.44141558695, 60635.09047364381, 7532.811679708051, 7624.199459056941, 7777.883331749915, 7926.365890728613, 7981.8403631928195, 10967.451627418437, 12608.74782504363, 12858.871411285767, 13028.869711303145, 13177.341132943506, 11418.657440276806, 11444.484998174936, 11487.597934072268, 11490.77018459643, 11617.477213525242, 11072.169587281147, 11158.49786759614, 11345.773084538429, 11525.481353339288, 11742.236754610924, 10427.635032773816, 11657.0, 11825.704357391134, 11869.287842729464, 11941.283522988648, 7166.498345115792, 7731.92268077312, 7797.532148071134, 7853.607319633881, 8117.756467305991, 11326.357678136788, 11493.367864767519, 11657.125715571536, 11791.410429478663, 11799.0], "value": 9394.120087196063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.68975445893, 1418.8510206428325, 1490.8956373053886, 1555.26125090582, 1722.035660030383, 8389.958050209749, 8727.825443491134, 8793.208611224989, 8996.550172491381, 9000.369974101815, 8845.91154088459, 8905.243054340388, 8906.153915378045, 8921.55392230389, 8956.46261224327, 2306.2850516339945, 2331.3122628824453, 2332.825038122139, 2334.11303704592, 2340.1458467659354, 2354.0348457132577, 2369.656399822025, 2435.8782060896974, 2437.5368679950843, 2445.254197469771, 2369.5024044950583, 2373.086361750721, 2399.1123284384803, 2403.531311394279, 2406.2901444073955, 2283.1666441748807, 2292.6331786914097, 2296.334063121693, 2312.8612283262974, 2323.639835825433, 2299.1378233162563, 2299.1952816514254, 2299.678045073691, 2305.3660243433023, 2311.133325003124, 8852.690155844515, 8894.86657700135, 8906.421082629673, 8949.507777072258, 8956.328275379308, 5255.211718242256, 5375.274337964403, 5386.165144402624, 5395.298611180521, 5398.379186393537, 3397.2695870387984, 3414.726821854246, 3462.3594634992355, 3481.634428385034, 3486.442169252907, 1049.6588608702202, 1067.4982758103756, 2157.6547752359547, 2260.559190957764, 2273.3180045986137, 12383.876161238453, 12393.504259829686, 12432.067594930417, 12499.0, 12543.937280313632, 4369.0, 4478.261086920622, 4575.130725162208, 4578.9771051144535, 4664.533546645308, 9927.255455840841, 9930.602775888883, 9930.950345248228, 9936.0, 9938.10557049869, 5432.565394768409, 5432.6468779529205, 5438.428964958702, 5440.891182176334, 5445.482679145475, 4388.978055109704, 4913.164761990471, 5026.572741317029, 5066.949330506648, 5087.821926232638, 3809.7333186676665, 3862.613738626115, 3925.2738243425056, 3962.405639154092, 3991.6806655467494, 1100.6092837042895, 1108.7560736637927, 1109.5506319940437, 1109.9944500277447, 1117.5082963496036, 794.5232860283899, 837.9287760540301, 886.5877367024235, 939.572494514994, 997.8175861604022, 5781.94218057814, 5856.970715146397, 5988.921994041028, 6095.512359011268, 6245.313015568284, 430.3802524364905, 444.03201021772844, 446.82127149140604, 1026.645807196516, 1061.2836335473523, 3701.833417496219, 3809.104860357814, 3874.1089549403796, 3943.132510847609, 3974.7813870237414, 11075.280106793032, 11515.309081454972, 11517.25137866036, 11524.308541487537, 11530.423478826193, 11297.435128243555, 11326.093912486982, 11406.144539159597, 11505.654830355103, 11518.136139789549, 8362.58187090643, 8402.663893444194, 8511.914880851236, 8523.360747943929, 8526.232639062515, 5615.691136987505, 5695.231143795535, 5713.800016999385, 5730.226419433323, 5932.13983972313, 9496.857547136937, 10531.368117912949, 10539.15686745074, 10564.313319634199, 10663.306885052447, 9933.056359645821, 10109.0, 10147.289689721649, 10199.643012494527, 10221.744456388353, 7217.422606191597, 7280.381167600602, 7705.460617756703, 7913.723019694283, 8093.231143041402, 8465.788355291166, 8830.0, 8837.558122093998, 8845.55772211374, 8851.778705532413, 7764.495307804975, 7950.16523265072, 8043.517388956681, 8084.474509156886, 8319.126491718282, 7734.806629834299, 7771.184025677222, 7932.6033698313695, 7970.880436793337, 8003.159668234752, 6969.965150174216, 7073.681684324115, 7073.787786366417, 7073.929260707327, 7077.964610176916, 5135.87160320995, 5345.33183352081, 5365.731713414391, 5381.977424289373, 5475.159184814011, 5040.672356296829, 5069.847904562869, 5082.847514574569, 5090.592752579711, 5120.846374608767], "value": 4664.00968654104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2370235138019, 332.3403044955762, 337.73319077928437, 338.90341252742974, 341.6327447993408, 5098.0, 5196.896062078766, 5281.234221037952, 5288.788448462057, 5303.382468347153, 5187.533122019017, 5192.55863251624, 5214.0, 5231.764570594323, 5240.213967904816, 4095.75425474471, 4097.242010228118, 4105.30209864323, 4110.219058378913, 4137.5448700643055, 4021.6380525752675, 4123.3196522573735, 4130.256553820311, 4150.398192262121, 4153.958460415402, 4077.5718549552316, 4083.734557253769, 4085.142120154771, 4099.713020088595, 4100.482821356102, 4075.816588253536, 4076.408920706481, 4076.408920706511, 4077.9601201693677, 4125.0, 3467.9479807802904, 3604.53141091659, 3624.855005799765, 3627.782333060025, 3630.2739452109686, 5084.949150508522, 5106.64253502255, 5112.105381558213, 5120.463860841733, 5122.9764243123755, 4687.929681054787, 4695.577398034159, 4698.224792909165, 4706.517447004183, 4706.576408123286, 5268.420473747885, 5434.755436005389, 5475.563374298439, 5476.26070480488, 5489.670619762827, 3985.326163011542, 3995.760254384746, 3997.6601988830985, 3997.900052498682, 3999.960000400017, 5678.687672178028, 5716.228309178249, 5719.342275638355, 5729.939961107167, 5738.569607279429, 3974.9863784734707, 4068.8575899843363, 4071.91856162881, 4094.5700701426517, 4095.9795201023803, 4101.0, 4101.420952933142, 4113.650339721157, 4117.1765646870745, 4117.75293482392, 4668.11305851887, 4674.158651442773, 4681.180793361148, 4688.97655511727, 4702.764861756898, 5285.2600635911, 5490.450954904558, 5528.585356098229, 5542.75057622408, 5584.553235741131, 1328.5217321764158, 1374.9725005499834, 1378.6070969773566, 1386.646405166676, 1400.5798260521804, 951.9476428796482, 956.5886668732512, 972.7665360313474, 977.1840513171582, 981.5877331520778, 5269.103122875762, 5282.181261904411, 5285.867853303621, 5287.154055351125, 5287.154055351202, 5565.0, 5575.191597218381, 5579.963313390584, 5587.552995760329, 5589.524890384281, 5073.670211436245, 5263.55252305619, 5267.604929630293, 5283.867903302448, 5367.470270972754, 3000.804947678394, 3018.743406810446, 3027.2431892026993, 3030.2878823476467, 3050.816950982948, 5870.853228669317, 5874.94125058744, 5894.381089985575, 5907.438793314628, 5915.349311575723, 5561.833145005657, 5746.482816546531, 5747.971260143756, 5778.306603207642, 5779.653220806765, 5839.678817665069, 5843.860447212753, 5852.951466986606, 5853.946289667901, 5878.2064421304285, 5401.918971215514, 5639.830805075854, 5647.548196144381, 5675.716214189357, 5681.659100453986, 5597.608167428241, 5609.298837645294, 5610.120609595831, 5630.88738225225, 5638.605297629127, 5836.80345529174, 5871.119332100219, 5876.676782776988, 5915.881682366243, 5916.26046744157, 3878.612138786099, 3940.4680368149934, 3948.2824971137647, 3981.56202817684, 3983.2232714620372, 5441.911617676401, 5624.943750562442, 5672.631278966854, 5698.886022279614, 5704.429557044263, 5460.91808622863, 5511.090670039399, 5574.581906356958, 5590.748416321357, 5597.496225339739, 5535.169724541351, 5554.916676249779, 5580.1629755537, 5585.525230355465, 5603.691796951207, 5284.603654725834, 5506.981208476284, 5519.586031047607, 5524.392316845064, 5531.8893622128135, 5630.380658127521, 5638.548916086621, 5644.923516683335, 5648.293963254593, 5653.236813030353, 5418.45815418455, 5531.902134804523, 5584.720763961867, 5595.272614560081, 5604.719764011702], "value": 4217.422029737295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1489819665499, 713.7858642407276, 727.4834867244256, 756.0511557994715, 782.3897360059156, 14917.104973701573, 16510.17449127542, 16519.752203716955, 16536.58658533537, 16543.00741955482, 13471.528496502624, 13631.318434078306, 13747.58757237282, 13856.515021974234, 15270.0, 795.5862951265353, 811.8822770698246, 814.0922870998824, 815.8776183572452, 817.7015389382863, 815.4780940198278, 819.848328059308, 821.8849361089452, 822.0382152881114, 822.2640736540792, 861.1130535548364, 861.9655213791441, 864.256739204287, 865.0398058155442, 865.2040123086744, 862.611824678897, 863.1497974495118, 863.3179787967498, 863.4517081653164, 864.9524276164808, 625.3933684326196, 625.837282306599, 626.786892456567, 626.9780557680459, 627.0249761620678, 13549.119307244997, 13925.30373481332, 13926.721465570632, 13998.860011399858, 14018.0, 13277.0, 13368.799468007988, 13757.79363309551, 13775.931120344434, 13817.240051797147, 12661.30362830044, 12678.80981785274, 13155.868441315655, 13476.797848032287, 13880.652983675387, 4449.644028477714, 4593.494715581283, 4629.467611224719, 4665.5567721066445, 4741.193997020515, 73646.63176684083, 73751.26248737551, 74006.0, 74230.0, 75082.62458687671, 11542.19204655666, 11703.686775599048, 11737.061035117342, 11878.643640690792, 11927.403629818475, 21075.68386474204, 21086.156553737987, 21214.681779773317, 21387.14451421957, 21434.464138396666, 8731.25784308341, 8747.256483198998, 8808.779780505538, 8881.73354799357, 8900.866487002571, 4945.876353091202, 4961.131801934719, 4990.700557966461, 5088.262201980766, 5170.71561064145, 3408.3183363327435, 3518.630543792916, 3539.0444579963264, 3543.4153364694535, 3551.058969373118, 602.7498588085983, 609.2810483629271, 615.387689249191, 637.0507943164652, 648.2577448821073, 612.8192183305936, 620.4632992461578, 685.9931400686029, 722.9638518074075, 741.6217728958162, 9384.170056997365, 10029.899701003042, 10033.43478717182, 10895.945520272347, 10902.563897444172, 672.9528932974645, 736.5654263984275, 749.8462815122887, 769.9499532530367, 796.3430170109567, 4552.385427967249, 4989.3264409305, 4995.500449955048, 5027.195648696191, 5083.74581270935, 103953.0, 111426.0, 113060.0, 120590.39704801595, 120768.0, 56526.43473565212, 96623.51688241513, 100975.49512252392, 103070.96929030764, 105129.0, 87913.56043219742, 89639.0, 90257.0, 90971.0, 93287.0671293292, 9295.67465138717, 9424.790844318715, 9685.9031409685, 9866.0, 9939.403635781877, 51635.96728065493, 51710.74144629253, 52138.0, 52677.9464410702, 53032.0, 67613.32386676071, 68605.65697171482, 74856.0, 75652.0, 76016.23983760092, 13646.795298070736, 13780.793288100485, 13819.79270310926, 14100.506482273071, 14150.43398264058, 14628.780568291271, 14977.0, 15020.474283400028, 15211.619709507351, 16086.517404477885, 14014.402112974603, 14098.718025639635, 14161.929190353982, 14422.927885360506, 14728.189949552878, 14158.0, 14525.0, 14689.265536722907, 14721.631959201106, 14831.703365932837, 14176.362063707364, 14382.137071775727, 14538.200398978157, 14700.117992920032, 15015.699686006437, 11131.489912493367, 11403.486843092247, 11518.769624607294, 11707.941460292644, 11901.583444579399, 10765.838512422477, 11106.278091924, 11244.325340479598, 11649.650510484698, 12250.509979600716], "value": 7697.175603604549, "unit": "score"}], "name": "dromaeo_css", "value": 7332.640327690833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 118.0, 180.0, 115.0, 117.0, 148.0, 115.0, 151.0, 122.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 76.0, 75.0, 75.0, 75.0, 104.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 84.0, 85.0, 84.0, 130.0, 83.0, 84.0, 138.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 53.0, 52.0, 53.0, 53.0, 52.0, 60.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 76.0, 76.0, 76.0, 82.0, 76.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 120.0, 129.0, 135.0, 119.0, 126.0, 132.0, 166.0, 128.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 155.0, 160.0, 158.0, 154.0, 157.0, 155.0, 153.0, 154.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 62.0, 65.0, 63.0, 62.0, 63.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1478.2, "alertThreshold": 2.0}]} 13:33:39 INFO - Return code: 0 13:33:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:33:39 INFO - # TBPL SUCCESS # 13:33:39 INFO - Running post-action listener: _resource_record_post_action 13:33:39 INFO - [mozharness: 2016-07-26 20:33:39.075302Z] Finished run-tests step (success) 13:33:39 INFO - Running post-run listener: _resource_record_post_run 13:33:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558784512; Read time: 16; Write time: 383268 13:33:39 INFO - TinderboxPrint: CPU usage
12.9% 13:33:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:33:39 INFO - TinderboxPrint: I/O write bytes / time
558,784,512 / 383,268 13:33:39 INFO - TinderboxPrint: CPU idle
8,267.3 (87.0%) 13:33:39 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 13:33:39 INFO - TinderboxPrint: Swap in / out
0 / 0 13:33:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257568768; Read time: 0; Write time: 210736 13:33:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 301215744; Read time: 0; Write time: 172532 13:33:39 INFO - Running post-run listener: _upload_blobber_files 13:33:39 INFO - Blob upload gear active. 13:33:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:33:39 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 13:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:40 INFO - (blobuploader) - INFO - Done attempting. 13:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:44 INFO - (blobuploader) - INFO - Done attempting. 13:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:45 INFO - (blobuploader) - INFO - Done attempting. 13:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:33:45 INFO - Return code: 0 13:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f86108093c274af7897ba32090f1fbbb7d398b821e81f001976570b89595e79c65128952a1d2803b55f4e758f92cc4c5e4585f44b0a4ec86eb30c58432f1f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b2e38242dc2f393022d7d136340cb49605ed4d1e3593a8b8b1bada0cfec4161ccdaa9c8f1afb4896b9e62cf7edb1275ebc86e5d1bd1270daa6a66a268cdab3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1e4839a856624a446eb135a7237e150841d20f01b04f6822eb0d7a46019b2e7237262574f3e1e10bd9e3c528f7f3367d94bf4274d7ddda35eb198b8777373"} 13:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:33:45 INFO - Contents: 13:33:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f86108093c274af7897ba32090f1fbbb7d398b821e81f001976570b89595e79c65128952a1d2803b55f4e758f92cc4c5e4585f44b0a4ec86eb30c58432f1f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b2e38242dc2f393022d7d136340cb49605ed4d1e3593a8b8b1bada0cfec4161ccdaa9c8f1afb4896b9e62cf7edb1275ebc86e5d1bd1270daa6a66a268cdab3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1e4839a856624a446eb135a7237e150841d20f01b04f6822eb0d7a46019b2e7237262574f3e1e10bd9e3c528f7f3367d94bf4274d7ddda35eb198b8777373"} 13:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:33:45 INFO - Copying logs to upload dir... 13:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.932472 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-26 13:33:45.029875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:33:45.033905) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f86108093c274af7897ba32090f1fbbb7d398b821e81f001976570b89595e79c65128952a1d2803b55f4e758f92cc4c5e4585f44b0a4ec86eb30c58432f1f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b2e38242dc2f393022d7d136340cb49605ed4d1e3593a8b8b1bada0cfec4161ccdaa9c8f1afb4896b9e62cf7edb1275ebc86e5d1bd1270daa6a66a268cdab3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1e4839a856624a446eb135a7237e150841d20f01b04f6822eb0d7a46019b2e7237262574f3e1e10bd9e3c528f7f3367d94bf4274d7ddda35eb198b8777373"} build_url:https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/IguqwK7WT06z7yOeOWd0_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f86108093c274af7897ba32090f1fbbb7d398b821e81f001976570b89595e79c65128952a1d2803b55f4e758f92cc4c5e4585f44b0a4ec86eb30c58432f1f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b2e38242dc2f393022d7d136340cb49605ed4d1e3593a8b8b1bada0cfec4161ccdaa9c8f1afb4896b9e62cf7edb1275ebc86e5d1bd1270daa6a66a268cdab3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1e4839a856624a446eb135a7237e150841d20f01b04f6822eb0d7a46019b2e7237262574f3e1e10bd9e3c528f7f3367d94bf4274d7ddda35eb198b8777373"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:33:45.061031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:33:45.061475) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469562296.892643-691917554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:33:45.145188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:33:45.145552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:33:45.145873) ========= ========= Total master_lag: 0.19 =========