builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1469582371.82 results: success (0) buildid: 20160726165312 builduid: cad79e08426e4399a708150e23acd0ec revision: 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.824463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.824917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.825190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.839750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.840100) ========= 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=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 18:19:32-- 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% 223M=0s 2016-07-26 18:19:32 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.945876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.946215) ========= 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=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.995727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:31.996090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 --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 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 --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=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 18:19:32,518 truncating revision to first 12 chars 2016-07-26 18:19:32,518 Setting DEBUG logging. 2016-07-26 18:19:32,518 attempt 1/10 2016-07-26 18:19:32,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/462dc6b44adb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 18:19:32,824 unpacking tar archive at: mozilla-central-462dc6b44adb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:32.644963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:32.645288) ========= script_repo_revision: 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:32.645681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:32.645952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 18:19:32.655192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-26 18:19:32.655569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:19:33 INFO - MultiFileLogger online at 20160726 18:19:33 in /builds/slave/test 18:19:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:19:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:19:33 INFO - {'append_to_log': False, 18:19:33 INFO - 'base_work_dir': '/builds/slave/test', 18:19:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:19:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:19:33 INFO - 'branch': 'Firefox-Non-PGO', 18:19:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:19:33 INFO - 'config_files': ('talos/linux_config.py',), 18:19:33 INFO - 'default_actions': ('clobber', 18:19:33 INFO - 'read-buildbot-config', 18:19:33 INFO - 'download-and-extract', 18:19:33 INFO - 'populate-webroot', 18:19:33 INFO - 'create-virtualenv', 18:19:33 INFO - 'install', 18:19:33 INFO - 'run-tests'), 18:19:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:19:33 INFO - 'download_minidump_stackwalk': True, 18:19:33 INFO - 'download_symbols': 'ondemand', 18:19:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:19:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:19:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:19:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:19:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:19:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:19:33 INFO - 'installer_path': 'installer.exe', 18:19:33 INFO - 'log_level': 'info', 18:19:33 INFO - 'log_name': 'talos', 18:19:33 INFO - 'log_to_console': True, 18:19:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:19:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:19:33 INFO - 'opt_config_files': (), 18:19:33 INFO - 'pip_index': False, 18:19:33 INFO - 'sps_profile': False, 18:19:33 INFO - 'sps_profile_interval': 0, 18:19:33 INFO - 'suite': 'dromaeojs', 18:19:33 INFO - 'system_bits': '32', 18:19:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:19:33 INFO - 'title': 'talos-linux64-ix-054', 18:19:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:19:33 INFO - 'use_talos_json': True, 18:19:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:19:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:19:33 INFO - 'work_dir': 'build'} 18:19:33 INFO - [mozharness: 2016-07-27 01:19:33.268545Z] Running clobber step. 18:19:33 INFO - Running pre-action listener: _resource_record_pre_action 18:19:33 INFO - Running main action method: clobber 18:19:33 INFO - rmtree: /builds/slave/test/build 18:19:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:19:33 INFO - Running post-action listener: _resource_record_post_action 18:19:33 INFO - [mozharness: 2016-07-27 01:19:33.770060Z] Finished clobber step (success) 18:19:33 INFO - [mozharness: 2016-07-27 01:19:33.770161Z] Running read-buildbot-config step. 18:19:33 INFO - Running pre-action listener: _resource_record_pre_action 18:19:33 INFO - Running main action method: read_buildbot_config 18:19:33 INFO - Using buildbot properties: 18:19:33 INFO - { 18:19:33 INFO - "project": "", 18:19:33 INFO - "product": "firefox", 18:19:33 INFO - "script_repo_revision": "production", 18:19:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:19:33 INFO - "repository": "", 18:19:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:19:33 INFO - "buildid": "20160726165312", 18:19:33 INFO - "pgo_build": "False", 18:19:33 INFO - "basedir": "/builds/slave/test", 18:19:33 INFO - "buildnumber": 569, 18:19:33 INFO - "slavename": "talos-linux64-ix-054", 18:19:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:19:33 INFO - "platform": "ubuntu64_hw", 18:19:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:19:33 INFO - "branch": "mozilla-central", 18:19:33 INFO - "repo_path": "mozilla-central", 18:19:33 INFO - "revision": "462dc6b44adb4573e8ce6b0dd688c206ebd516f7", 18:19:33 INFO - "stage_platform": "linux64", 18:19:33 INFO - "builduid": "cad79e08426e4399a708150e23acd0ec", 18:19:33 INFO - "slavebuilddir": "test" 18:19:33 INFO - } 18:19:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:19:33 INFO - Running post-action listener: _resource_record_post_action 18:19:33 INFO - [mozharness: 2016-07-27 01:19:33.772617Z] Finished read-buildbot-config step (success) 18:19:33 INFO - [mozharness: 2016-07-27 01:19:33.772707Z] Running download-and-extract step. 18:19:33 INFO - Running pre-action listener: _resource_record_pre_action 18:19:33 INFO - Running main action method: download_and_extract 18:19:33 INFO - mkdir: /builds/slave/test/build/tests 18:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:33 INFO - https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:34 INFO - Downloaded 1361 bytes. 18:19:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:19:34 INFO - Using the following test package requirements: 18:19:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:19:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:19:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:19:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'jsshell-linux-x86_64.zip'], 18:19:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:19:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:19:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:19:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:19:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:19:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:19:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:19:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:19: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')]} 18:19:34 INFO - https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:35 INFO - Downloaded 22744272 bytes. 18:19:35 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'] 18:19:35 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 18:19:36 INFO - Return code: 0 18:19:36 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 18:19: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')]} 18:19:36 INFO - https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:37 INFO - Downloaded 22744272 bytes. 18:19:37 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'] 18:19:37 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 18:19:38 INFO - Return code: 0 18:19:38 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')]} 18:19:38 INFO - https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:39 INFO - Downloaded 14413725 bytes. 18:19:39 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'] 18:19:39 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 18:19:40 INFO - Return code: 0 18:19: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')]} 18:19:40 INFO - https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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 18:19:41 INFO - Downloaded 57170606 bytes. 18:19:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:19:41 INFO - mkdir: /builds/slave/test/properties 18:19:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:19:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:19:41 INFO - Contents: 18:19:41 INFO - build_url:https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:19:41 INFO - Running post-action listener: _resource_record_post_action 18:19:41 INFO - Running post-action listener: set_extra_try_arguments 18:19:41 INFO - [mozharness: 2016-07-27 01:19:41.945479Z] Finished download-and-extract step (success) 18:19:41 INFO - [mozharness: 2016-07-27 01:19:41.945711Z] Running populate-webroot step. 18:19:41 INFO - Running pre-action listener: _resource_record_pre_action 18:19:41 INFO - Running main action method: populate_webroot 18:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:19:41 INFO - '--tppagecycles', 18:19:41 INFO - '7'], 18:19:41 INFO - 'tests': ['tsvgm']}}, 18:19:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:19:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:19:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:19:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['damp', 'tps']}, 18:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'tests': ['damp', 'tps']}, 18:19:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['dromaeo_dom']}, 18:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:19:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['basic_compositor_video']}, 18:19:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:19:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['a11yr', 18:19:41 INFO - 'ts_paint', 18:19:41 INFO - 'tpaint', 18:19:41 INFO - 'sessionrestore', 18:19:41 INFO - 'sessionrestore_no_auto_restore', 18:19:41 INFO - 'tabpaint']}, 18:19:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['tsvgx', 18:19:41 INFO - 'tsvgr_opacity', 18:19:41 INFO - 'tart', 18:19:41 INFO - 'tscrollx', 18:19:41 INFO - 'cart']}, 18:19:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:19:41 INFO - 'tsvgr_opacity', 18:19:41 INFO - 'tart', 18:19:41 INFO - 'tscrollx', 18:19:41 INFO - 'cart']}, 18:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'talos_options': ['--disable-e10s'], 18:19:41 INFO - 'tests': ['tp5o']}, 18:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'tests': ['tp5o']}, 18:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'talos_options': ['--disable-e10s', 18:19:41 INFO - '--xperf_path', 18:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:41 INFO - 'tests': ['tp5n']}, 18:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:19:41 INFO - 'talos_options': ['--xperf_path', 18:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:41 INFO - 'tests': ['tp5n']}}, 18:19:41 INFO - 'talos.zip': {'path': '', 18:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:19:41 INFO - Running post-action listener: _resource_record_post_action 18:19:41 INFO - [mozharness: 2016-07-27 01:19:41.962858Z] Finished populate-webroot step (success) 18:19:41 INFO - [mozharness: 2016-07-27 01:19:41.962947Z] Running create-virtualenv step. 18:19:41 INFO - Running pre-action listener: _resource_record_pre_action 18:19:41 INFO - Running main action method: create_virtualenv 18:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:19:41 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 18:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:19:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:19:42 INFO - Using real prefix '/usr' 18:19:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:19:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:19:44 INFO - Installing pip.................done. 18:19:44 INFO - Return code: 0 18:19:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:44 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 18:19:44 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 18:19:44 INFO - Using env: {'DISPLAY': ':0', 18:19:44 INFO - 'HOME': '/home/cltbld', 18:19:44 INFO - 'LANG': 'en_US.UTF-8', 18:19:44 INFO - 'LANGUAGE': 'en_US:en', 18:19:44 INFO - 'LOGNAME': 'cltbld', 18:19:44 INFO - 'MAIL': '/var/mail/cltbld', 18:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:44 INFO - 'MOZ_NO_REMOTE': '1', 18:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:44 INFO - 'NO_EM_RESTART': '1', 18:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:44 INFO - 'PWD': '/builds/slave/test', 18:19:44 INFO - 'SHELL': '/bin/bash', 18:19:44 INFO - 'SHLVL': '1', 18:19:44 INFO - 'TERM': 'linux', 18:19:44 INFO - 'TMOUT': '86400', 18:19:44 INFO - 'USER': 'cltbld', 18:19:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:44 INFO - '_': '/tools/buildbot/bin/python'} 18:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:44 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 18:19:44 INFO - Cleaning up... 18:19:44 INFO - Return code: 0 18:19:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:44 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 18:19:44 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 18:19:44 INFO - Using env: {'DISPLAY': ':0', 18:19:44 INFO - 'HOME': '/home/cltbld', 18:19:44 INFO - 'LANG': 'en_US.UTF-8', 18:19:44 INFO - 'LANGUAGE': 'en_US:en', 18:19:44 INFO - 'LOGNAME': 'cltbld', 18:19:44 INFO - 'MAIL': '/var/mail/cltbld', 18:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:44 INFO - 'MOZ_NO_REMOTE': '1', 18:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:44 INFO - 'NO_EM_RESTART': '1', 18:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:44 INFO - 'PWD': '/builds/slave/test', 18:19:44 INFO - 'SHELL': '/bin/bash', 18:19:44 INFO - 'SHLVL': '1', 18:19:44 INFO - 'TERM': 'linux', 18:19:44 INFO - 'TMOUT': '86400', 18:19:44 INFO - 'USER': 'cltbld', 18:19:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:44 INFO - '_': '/tools/buildbot/bin/python'} 18:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:44 INFO - Downloading/unpacking psutil>=3.1.1 18:19:44 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 18:19:44 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 18:19:44 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 18:19:44 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 18:19:44 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 18:19:44 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 18:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:47 INFO - Installing collected packages: psutil 18:19:47 INFO - Running setup.py install for psutil 18:19:47 INFO - building 'psutil._psutil_linux' extension 18:19:47 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 18:19:47 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 18:19:47 INFO - building 'psutil._psutil_posix' extension 18:19:47 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 18:19:47 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 18:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:47 INFO - Successfully installed psutil 18:19:47 INFO - Cleaning up... 18:19:47 INFO - Return code: 0 18:19:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:19: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 mozsystemmonitor==0.3 18:19:47 INFO - Using env: {'DISPLAY': ':0', 18:19:47 INFO - 'HOME': '/home/cltbld', 18:19:47 INFO - 'LANG': 'en_US.UTF-8', 18:19:47 INFO - 'LANGUAGE': 'en_US:en', 18:19:47 INFO - 'LOGNAME': 'cltbld', 18:19:47 INFO - 'MAIL': '/var/mail/cltbld', 18:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:47 INFO - 'MOZ_NO_REMOTE': '1', 18:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:47 INFO - 'NO_EM_RESTART': '1', 18:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:47 INFO - 'PWD': '/builds/slave/test', 18:19:47 INFO - 'SHELL': '/bin/bash', 18:19:47 INFO - 'SHLVL': '1', 18:19:47 INFO - 'TERM': 'linux', 18:19:47 INFO - 'TMOUT': '86400', 18:19:47 INFO - 'USER': 'cltbld', 18:19:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:47 INFO - '_': '/tools/buildbot/bin/python'} 18:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:19:47 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 18:19:47 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 18:19:47 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 18:19:47 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 18:19:47 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 18:19:47 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 18:19:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:19:49 INFO - Installing collected packages: mozsystemmonitor 18:19:49 INFO - Running setup.py install for mozsystemmonitor 18:19:49 INFO - Successfully installed mozsystemmonitor 18:19:49 INFO - Cleaning up... 18:19:49 INFO - Return code: 0 18:19:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:49 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:49 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 18:19:49 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 18:19:49 INFO - Using env: {'DISPLAY': ':0', 18:19:49 INFO - 'HOME': '/home/cltbld', 18:19:49 INFO - 'LANG': 'en_US.UTF-8', 18:19:49 INFO - 'LANGUAGE': 'en_US:en', 18:19:49 INFO - 'LOGNAME': 'cltbld', 18:19:49 INFO - 'MAIL': '/var/mail/cltbld', 18:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:49 INFO - 'MOZ_NO_REMOTE': '1', 18:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:49 INFO - 'NO_EM_RESTART': '1', 18:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:49 INFO - 'PWD': '/builds/slave/test', 18:19:49 INFO - 'SHELL': '/bin/bash', 18:19:49 INFO - 'SHLVL': '1', 18:19:49 INFO - 'TERM': 'linux', 18:19:49 INFO - 'TMOUT': '86400', 18:19:49 INFO - 'USER': 'cltbld', 18:19:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:49 INFO - '_': '/tools/buildbot/bin/python'} 18:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:50 INFO - Downloading/unpacking jsonschema==2.5.1 18:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:19:51 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 18:19:51 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 18:19:51 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 18:19:51 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 18:19:51 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 18:19:51 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 18:19:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:52 INFO - warning: no files found matching '*.txt' 18:19:52 INFO - no previously-included directories found matching 'build' 18:19:52 INFO - no previously-included directories found matching 'dist' 18:19:52 INFO - no previously-included directories found matching '.git*' 18:19:52 INFO - Installing collected packages: jsonschema, functools32 18:19:52 INFO - Running setup.py install for functools32 18:19:52 INFO - warning: no files found matching '*.txt' 18:19:52 INFO - no previously-included directories found matching 'build' 18:19:52 INFO - no previously-included directories found matching 'dist' 18:19:52 INFO - no previously-included directories found matching '.git*' 18:19:52 INFO - Successfully installed jsonschema functools32 18:19:52 INFO - Cleaning up... 18:19:52 INFO - Return code: 0 18:19:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:52 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:52 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 18:19:52 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 18:19:52 INFO - Using env: {'DISPLAY': ':0', 18:19:52 INFO - 'HOME': '/home/cltbld', 18:19:52 INFO - 'LANG': 'en_US.UTF-8', 18:19:52 INFO - 'LANGUAGE': 'en_US:en', 18:19:52 INFO - 'LOGNAME': 'cltbld', 18:19:52 INFO - 'MAIL': '/var/mail/cltbld', 18:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:52 INFO - 'MOZ_NO_REMOTE': '1', 18:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:52 INFO - 'NO_EM_RESTART': '1', 18:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:52 INFO - 'PWD': '/builds/slave/test', 18:19:52 INFO - 'SHELL': '/bin/bash', 18:19:52 INFO - 'SHLVL': '1', 18:19:52 INFO - 'TERM': 'linux', 18:19:52 INFO - 'TMOUT': '86400', 18:19:52 INFO - 'USER': 'cltbld', 18:19:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:52 INFO - '_': '/tools/buildbot/bin/python'} 18:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:19:52 INFO - Cleaning up... 18:19:52 INFO - Return code: 0 18:19:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:52 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:52 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 18:19:52 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 18:19:52 INFO - Using env: {'DISPLAY': ':0', 18:19:52 INFO - 'HOME': '/home/cltbld', 18:19:52 INFO - 'LANG': 'en_US.UTF-8', 18:19:52 INFO - 'LANGUAGE': 'en_US:en', 18:19:52 INFO - 'LOGNAME': 'cltbld', 18:19:52 INFO - 'MAIL': '/var/mail/cltbld', 18:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:52 INFO - 'MOZ_NO_REMOTE': '1', 18:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:52 INFO - 'NO_EM_RESTART': '1', 18:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:52 INFO - 'PWD': '/builds/slave/test', 18:19:52 INFO - 'SHELL': '/bin/bash', 18:19:52 INFO - 'SHLVL': '1', 18:19:52 INFO - 'TERM': 'linux', 18:19:52 INFO - 'TMOUT': '86400', 18:19:52 INFO - 'USER': 'cltbld', 18:19:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:52 INFO - '_': '/tools/buildbot/bin/python'} 18:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:54 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 18:19:54 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 18:19:54 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 18:19:54 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 18:19:54 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 18:19:54 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 18:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:19:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:55 INFO - Downloading docopt-0.6.1.tar.gz 18:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:55 INFO - Running setup.py install for blobuploader 18:19:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:19:55 INFO - Running setup.py install for requests 18:19:56 INFO - Running setup.py install for docopt 18:19:56 INFO - Successfully installed blobuploader requests docopt 18:19:56 INFO - Cleaning up... 18:19:56 INFO - Return code: 0 18:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:56 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:56 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 18:19:56 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 18:19:56 INFO - Using env: {'DISPLAY': ':0', 18:19:56 INFO - 'HOME': '/home/cltbld', 18:19:56 INFO - 'LANG': 'en_US.UTF-8', 18:19:56 INFO - 'LANGUAGE': 'en_US:en', 18:19:56 INFO - 'LOGNAME': 'cltbld', 18:19:56 INFO - 'MAIL': '/var/mail/cltbld', 18:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:56 INFO - 'MOZ_NO_REMOTE': '1', 18:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:56 INFO - 'NO_EM_RESTART': '1', 18:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:56 INFO - 'PWD': '/builds/slave/test', 18:19:56 INFO - 'SHELL': '/bin/bash', 18:19:56 INFO - 'SHLVL': '1', 18:19:56 INFO - 'TERM': 'linux', 18:19:56 INFO - 'TMOUT': '86400', 18:19:56 INFO - 'USER': 'cltbld', 18:19:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:56 INFO - '_': '/tools/buildbot/bin/python'} 18:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:56 INFO - Running setup.py (path:/tmp/pip-Q84RAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:56 INFO - Running setup.py (path:/tmp/pip-7S7Omu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:56 INFO - Running setup.py (path:/tmp/pip-NF92zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:56 INFO - Running setup.py (path:/tmp/pip-f74Tmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:56 INFO - Running setup.py (path:/tmp/pip-jQMf28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:56 INFO - Running setup.py (path:/tmp/pip-HpwtYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:56 INFO - Running setup.py (path:/tmp/pip-4AafCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:56 INFO - Running setup.py (path:/tmp/pip-H9Y0jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:56 INFO - Running setup.py (path:/tmp/pip-cqZ6qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:57 INFO - Running setup.py (path:/tmp/pip-hFoDSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:57 INFO - Running setup.py (path:/tmp/pip-wnZkkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:57 INFO - Running setup.py (path:/tmp/pip-7a3v_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:57 INFO - Running setup.py (path:/tmp/pip-4zQcJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:57 INFO - Running setup.py (path:/tmp/pip-oja4Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:57 INFO - Running setup.py (path:/tmp/pip-zKMI7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:57 INFO - Running setup.py (path:/tmp/pip-vi1mSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:57 INFO - Running setup.py (path:/tmp/pip-NzEqdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:57 INFO - Running setup.py install for manifestparser 18:19:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:19:57 INFO - Running setup.py install for mozcrash 18:19:57 INFO - Running setup.py install for mozdebug 18:19:57 INFO - Running setup.py install for mozdevice 18:19:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:19:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozfile 18:19:58 INFO - Running setup.py install for mozhttpd 18:19:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozinfo 18:19:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozInstall 18:19:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozleak 18:19:58 INFO - Running setup.py install for mozlog 18:19:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for moznetwork 18:19:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozprocess 18:19:58 INFO - Running setup.py install for mozprofile 18:19:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:58 INFO - Running setup.py install for mozrunner 18:19:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:59 INFO - Running setup.py install for mozscreenshot 18:19:59 INFO - Running setup.py install for moztest 18:19:59 INFO - Running setup.py install for mozversion 18:19:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:59 INFO - Cleaning up... 18:19:59 INFO - Return code: 0 18:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:59 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:19:59 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 18:19:59 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 18:19:59 INFO - Using env: {'DISPLAY': ':0', 18:19:59 INFO - 'HOME': '/home/cltbld', 18:19:59 INFO - 'LANG': 'en_US.UTF-8', 18:19:59 INFO - 'LANGUAGE': 'en_US:en', 18:19:59 INFO - 'LOGNAME': 'cltbld', 18:19:59 INFO - 'MAIL': '/var/mail/cltbld', 18:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:59 INFO - 'MOZ_NO_REMOTE': '1', 18:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:59 INFO - 'NO_EM_RESTART': '1', 18:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:59 INFO - 'PWD': '/builds/slave/test', 18:19:59 INFO - 'SHELL': '/bin/bash', 18:19:59 INFO - 'SHLVL': '1', 18:19:59 INFO - 'TERM': 'linux', 18:19:59 INFO - 'TMOUT': '86400', 18:19:59 INFO - 'USER': 'cltbld', 18:19:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:59 INFO - '_': '/tools/buildbot/bin/python'} 18:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:59 INFO - Running setup.py (path:/tmp/pip-YasMzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:59 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)) 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:59 INFO - Running setup.py (path:/tmp/pip-R9U3Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:59 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)) 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:59 INFO - Running setup.py (path:/tmp/pip-2WjeSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:59 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)) 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:59 INFO - Running setup.py (path:/tmp/pip-F5FvzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:59 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)) 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:59 INFO - Running setup.py (path:/tmp/pip-TGBdrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:59 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)) 18:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:59 INFO - Running setup.py (path:/tmp/pip-5GGvgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:00 INFO - Running setup.py (path:/tmp/pip-gkLrbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:00 INFO - Running setup.py (path:/tmp/pip-xYcaZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:00 INFO - Running setup.py (path:/tmp/pip-pcCJvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:00 INFO - Running setup.py (path:/tmp/pip-Ena1VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:00 INFO - Running setup.py (path:/tmp/pip-FxGEO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:00 INFO - Running setup.py (path:/tmp/pip-6OY3N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:00 INFO - Running setup.py (path:/tmp/pip-rXgPCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:00 INFO - Running setup.py (path:/tmp/pip-hdSA7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:00 INFO - Running setup.py (path:/tmp/pip-BHtPCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:00 INFO - Running setup.py (path:/tmp/pip-HESIU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:00 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)) 18:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:00 INFO - Running setup.py (path:/tmp/pip-5tjLQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:00 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)) 18:20:00 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)) 18:20:00 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)) 18:20:00 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)) 18:20:00 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)) 18:20:00 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)) 18:20:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:00 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 18:20:00 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 18:20:00 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 18:20:00 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 18:20:00 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 18:20:00 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 18:20:02 INFO - Downloading blessings-1.6.tar.gz 18:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:20:02 INFO - Installing collected packages: blessings 18:20:02 INFO - Running setup.py install for blessings 18:20:02 INFO - Successfully installed blessings 18:20:02 INFO - Cleaning up... 18:20:02 INFO - Return code: 0 18:20:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:03 INFO - Reading from file tmpfile_stdout 18:20:03 INFO - Current package versions: 18:20:03 INFO - argparse == 1.2.1 18:20:03 INFO - blessings == 1.6 18:20:03 INFO - blobuploader == 1.2.4 18:20:03 INFO - docopt == 0.6.1 18:20:03 INFO - functools32 == 3.2.3-2 18:20:03 INFO - jsonschema == 2.5.1 18:20:03 INFO - manifestparser == 1.1 18:20:03 INFO - mozInstall == 1.12 18:20:03 INFO - mozcrash == 0.17 18:20:03 INFO - mozdebug == 0.1 18:20:03 INFO - mozdevice == 0.48 18:20:03 INFO - mozfile == 1.2 18:20:03 INFO - mozhttpd == 0.7 18:20:03 INFO - mozinfo == 0.9 18:20:03 INFO - mozleak == 0.1 18:20:03 INFO - mozlog == 3.3 18:20:03 INFO - moznetwork == 0.27 18:20:03 INFO - mozprocess == 0.23 18:20:03 INFO - mozprofile == 0.28 18:20:03 INFO - mozrunner == 6.12 18:20:03 INFO - mozscreenshot == 0.1 18:20:03 INFO - mozsystemmonitor == 0.3 18:20:03 INFO - moztest == 0.7 18:20:03 INFO - mozversion == 1.4 18:20:03 INFO - psutil == 3.1.1 18:20:03 INFO - requests == 1.2.3 18:20:03 INFO - wsgiref == 0.1.2 18:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:03 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 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:20:03 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 18:20:03 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 18:20:03 INFO - Using env: {'DISPLAY': ':0', 18:20:03 INFO - 'HOME': '/home/cltbld', 18:20:03 INFO - 'LANG': 'en_US.UTF-8', 18:20:03 INFO - 'LANGUAGE': 'en_US:en', 18:20:03 INFO - 'LOGNAME': 'cltbld', 18:20:03 INFO - 'MAIL': '/var/mail/cltbld', 18:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:03 INFO - 'MOZ_NO_REMOTE': '1', 18:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:03 INFO - 'NO_EM_RESTART': '1', 18:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:03 INFO - 'PWD': '/builds/slave/test', 18:20:03 INFO - 'SHELL': '/bin/bash', 18:20:03 INFO - 'SHLVL': '1', 18:20:03 INFO - 'TERM': 'linux', 18:20:03 INFO - 'TMOUT': '86400', 18:20:03 INFO - 'USER': 'cltbld', 18:20:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:03 INFO - '_': '/tools/buildbot/bin/python'} 18:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 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)) 18:20:03 INFO - Cleaning up... 18:20:03 INFO - Return code: 0 18:20:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b97180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, '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': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', '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 18:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:20:03 INFO - Using env: {'DISPLAY': ':0', 18:20:03 INFO - 'HOME': '/home/cltbld', 18:20:03 INFO - 'LANG': 'en_US.UTF-8', 18:20:03 INFO - 'LANGUAGE': 'en_US:en', 18:20:03 INFO - 'LOGNAME': 'cltbld', 18:20:03 INFO - 'MAIL': '/var/mail/cltbld', 18:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:03 INFO - 'MOZ_NO_REMOTE': '1', 18:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:03 INFO - 'NO_EM_RESTART': '1', 18:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:03 INFO - 'PWD': '/builds/slave/test', 18:20:03 INFO - 'SHELL': '/bin/bash', 18:20:03 INFO - 'SHLVL': '1', 18:20:03 INFO - 'TERM': 'linux', 18:20:03 INFO - 'TMOUT': '86400', 18:20:03 INFO - 'USER': 'cltbld', 18:20:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:03 INFO - '_': '/tools/buildbot/bin/python'} 18:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:20:03 INFO - Cleaning up... 18:20:03 INFO - Return code: 0 18:20:03 INFO - Running post-action listener: _resource_record_post_action 18:20:03 INFO - Running post-action listener: _start_resource_monitoring 18:20:03 INFO - Starting resource monitoring. 18:20:03 INFO - [mozharness: 2016-07-27 01:20:03.687326Z] Finished create-virtualenv step (success) 18:20:03 INFO - [mozharness: 2016-07-27 01:20:03.687896Z] Running install step. 18:20:03 INFO - Running pre-action listener: _resource_record_pre_action 18:20:03 INFO - Running main action method: install 18:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:03 INFO - Reading from file tmpfile_stdout 18:20:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:20:03 INFO - Reading from file tmpfile_stdout 18:20:03 INFO - Output received: 18:20:03 INFO - Usage: mozinstall [options] installer 18:20:03 INFO - Options: 18:20:03 INFO - -h, --help show this help message and exit 18:20:03 INFO - -d DEST, --destination=DEST 18:20:03 INFO - Directory to install application into. [default: 18:20:03 INFO - "/builds/slave/test"] 18:20:03 INFO - --app=APP Application being installed. [default: firefox] 18:20:03 INFO - mkdir: /builds/slave/test/build/application 18:20:03 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'] 18:20:03 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 18:20:20 INFO - Reading from file tmpfile_stdout 18:20:20 INFO - Output received: 18:20:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:20:20 INFO - Running post-action listener: _resource_record_post_action 18:20:20 INFO - [mozharness: 2016-07-27 01:20:20.386356Z] Finished install step (success) 18:20:20 INFO - [mozharness: 2016-07-27 01:20:20.386638Z] Running run-tests step. 18:20:20 INFO - Running pre-action listener: _resource_record_pre_action 18:20:20 INFO - Running main action method: run_tests 18:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:20:20 INFO - Python 2.7.3 18:20:20 INFO - Return code: 0 18:20:20 INFO - grabbing minidump binary from tooltool 18:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:20 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 0x1b953b0>, '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 0x1b962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b96740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:20:20 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 18:20:20 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 18:20:20 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 18:20:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:20:20 INFO - Return code: 0 18:20:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:20:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:20:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:20:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:20:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 18:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 18:20:20 INFO - Using env: {'DISPLAY': ':0', 18:20:20 INFO - 'HOME': '/home/cltbld', 18:20:20 INFO - 'LANG': 'en_US.UTF-8', 18:20:20 INFO - 'LANGUAGE': 'en_US:en', 18:20:20 INFO - 'LOGNAME': 'cltbld', 18:20:20 INFO - 'MAIL': '/var/mail/cltbld', 18:20:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:20:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:20 INFO - 'MOZ_NO_REMOTE': '1', 18:20:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:20 INFO - 'NO_EM_RESTART': '1', 18:20:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:20 INFO - 'PWD': '/builds/slave/test', 18:20:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:20:20 INFO - 'SHELL': '/bin/bash', 18:20:20 INFO - 'SHLVL': '1', 18:20:20 INFO - 'TERM': 'linux', 18:20:20 INFO - 'TMOUT': '86400', 18:20:20 INFO - 'USER': 'cltbld', 18:20:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772', 18:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:20 INFO - '_': '/tools/buildbot/bin/python'} 18:20:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 18:20:20 INFO - mozversion application_buildid: 20160726165312 18:20:20 INFO - mozversion application_changeset: 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 18:20:20 INFO - mozversion application_display_name: Nightly 18:20:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:20:20 INFO - mozversion application_name: Firefox 18:20:20 INFO - mozversion application_remotingname: firefox 18:20:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:20:20 INFO - mozversion application_vendor: Mozilla 18:20:20 INFO - mozversion application_version: 50.0a1 18:20:20 INFO - mozversion platform_buildid: 20160726165312 18:20:20 INFO - mozversion platform_changeset: 462dc6b44adb4573e8ce6b0dd688c206ebd516f7 18:20:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:20:20 INFO - mozversion platform_version: 50.0a1 18:20:20 INFO - using testdate: 1469582420 18:20:20 INFO - actual date: 1469582420 18:20:20 INFO - starting webserver on 'localhost:52285' 18:20:20 INFO - SUITE-START | Running 2 tests 18:20:20 INFO - TEST-START | dromaeo_css 18:20:20 INFO - operating with platform_type : linux_ 18:20:20 INFO - Initialising browser for dromaeo_css test... 18:20:20 INFO - TEST-INFO | started process 25367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mVzOM/profile http://localhost:52285/getInfo.html) 18:20:24 INFO - PROCESS | 25367 | JavaScript error: , line 0: uncaught exception: undefined 18:20:25 INFO - PROCESS | 25367 | __metrics Screen width/height:1600/1200 18:20:25 INFO - PROCESS | 25367 | colorDepth:24 18:20:25 INFO - PROCESS | 25367 | Browser inner width/height: 1024/697 18:20:25 INFO - PROCESS | 25367 | __metrics 18:20:25 INFO - PROCESS | 25367 | 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" 18:20:25 INFO - PROCESS | 25367 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:20:27 INFO - TEST-INFO | 25367: exit 0 18:20:27 INFO - Browser initialized. 18:20:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:20:27 INFO - TEST-INFO | started process 25445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mVzOM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:38 INFO - PROCESS | 25445 | RSS: Main: 159637504 18:20:38 INFO - PROCESS | 25445 | 18:21:29 INFO - PROCESS | 25445 | 1469582489783 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] 18:23:42 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52285/tests/dromaeo/cssquery-ext.html) 18:23:44 INFO - PROCESS | 25445 | RSS: Main: 337248256 18:23:44 INFO - PROCESS | 25445 | 18:26:47 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-ext.html (next: http://localhost:52285/tests/dromaeo/cssquery-jquery.html) 18:26:48 INFO - PROCESS | 25445 | RSS: Main: 247390208 18:26:48 INFO - PROCESS | 25445 | 18:29:50 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52285/tests/dromaeo/cssquery-mootools.html) 18:29:50 INFO - PROCESS | 25445 | RSS: Main: 191942656 18:29:50 INFO - PROCESS | 25445 | 18:32:53 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52285/tests/dromaeo/cssquery-prototype.html) 18:32:53 INFO - PROCESS | 25445 | RSS: Main: 193060864 18:32:53 INFO - PROCESS | 25445 | 18:35:56 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52285/tests/dromaeo/cssquery-yui.html) 18:35:57 INFO - PROCESS | 25445 | RSS: Main: 191156224 18:35:57 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-yui.html (next: http://localhost:52285/tests/dromaeo/cssquery-dojo.html) 18:39:00 INFO - PROCESS | 25445 | RSS: Main: 271548416 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | __start_tp_report 18:39:00 INFO - PROCESS | 25445 | _x_x_mozilla_page_load 18:39:00 INFO - PROCESS | 25445 | _x_x_mozilla_page_load_details 18:39:00 INFO - PROCESS | 25445 | |i|pagename|runs| 18:39:00 INFO - PROCESS | 25445 | |0;dojo.html;2608.6608740863685;2609.2172348295508;2654.416028473735;2659.6808382994036;2680.3701130234404;4595.770211489429;4699.459562150354;4721.055788842233;4753.382060332161;4817.855464336071;4697.882552936178;4721.952780472194;4737.715737055779;4750.429948406196;4797.304390863332;4319.157764235975;4368.366586844905;4383.079553293812;4448.710833795809;4459.821607135711;4374.60628543431;4418.072204836972;4435.645148388121;4450.710703804242;4486.7083639563325;4506.909861802762;4526.6831321807485;4528.773561321937;4547.567981041796;4556.97721511392;4278.379634952915;4314.245007123772;4333;4349.456317960255;4379.0585024219945;4299.72051816634;4306.74159550428;4309.332053531708;4314.784260786948;4388.7147335423415;4758.976205118987;4769.35613692154;4784.832530861403;4791.880202994918;4801.231802911518;4864.975675121637;4955.653104282702;4979.352684151074;4994.650374473788;5047.798088076473;5019.071471777733;5097.847064588068;5101.2603172539775;5102.566281866046;5141.562967147797;4778.1399348116975;4780.928286075712;4794.880127996828;4803.759812009455;4816.903661926742;5006.924896126561;5093.643444958817;5146.742662866842;5278.815241466607;5285.735713214324;4965.702057876539;4982;4988.5260900214425;5006.123928312531;5008.824691135793;5027.396712394536;5057.822976195889;5066.645334826527;5084.313617661643;5101.617378696613;4855.32025516428;4901.436334821541;4976.954839483677;4992.600591952635;5006.4743201964;4992.600591952635;5092.337996060563;5103.081445339801;5104.2088476286235;5105.463926287686;4295.484541854935;4297.484301883732;4306.4832220133785;4333.891652708708;4340.934885976713;3779.168582911755;3784.0918179636687;3808.2383523295453;3832.0994566276904;3867.187890542961;4218.535961044283;4340.435743353407;4366.214081465367;4371.256886329332;4391.890202744893;5147.897042059138;5156.123459011977;5161.096808058574;5163.793448262102;5203.505666961632;4380.671449641226;4411.250087485135;4417.116576684676;4445.59989600931;4458.955410445854;4364.192624364503;4481.641468682497;4490.348899409567;4526.456825180933;4589.65577581676;4757.666963312535;4774.737389443614;4779.1636463619425;4811.566958973709;4819.397575303087;5064.088464076502;5075.6193285502995;5076.771545280545;5078.390593128848;5079.187330027178;4635.65232607549;4687.460941991714;4689.953100469088;4739.976300118477;4810.95189048105;4952.975235123801;4966.776495057803;4973.9751301244705;4977.9751101244265;4980.203167493184;4992.326035985096;5042.697438153723;5044.117279476003;5045.2432135180015;5047.87380315495;4899.902001960012;4907.337509436323;4915.582175515121;4926.852194434173;4969.4782047884455;4989.725565093955;4994.625403094709;4996.000799839974;5020.297158397901;5038.924416133834;4904.803807847788;4923.532264434873;4924.704517728947;4966.404031516241;4966.751662416937;4840.6127509799835;4905.386826646669;4907.5828554571835;4986.650934434555;5055.772490237875;4747.050589881968;4795.2567352059095;4818.325434439252;4862.878428039327;4899 18:39:00 INFO - PROCESS | 25445 | |1;ext.html;578.482258378751;578.8263520943716;581.5260562641449;592.5437413191845;598.1088178613863;26910.5963410549;38211;39057.60942390575;39343.80328098363;42897;39587;39822;39858.60141398585;40022.59977400225;40110.598894011055;7191.38873195779;7655.46411751179;7738.226177382273;7788.883166752503;7799.298063174313;7238.71045158193;7474.990876231721;7477.6635051422545;9662.758431039245;9887.653932112378;9988.850167247498;10045.949770251138;10048.899511004869;10049.799004019915;10082.848757268646;9871.555779989918;9951.950240248789;9958.402495850272;9959.502024898726;9963.65127220551;9417.387869788441;9474.763130921714;9476.431414115106;9478.763030924212;9479.052094790535;38428;38646.61353386458;38737.806310968546;38750;38860.805695971336;2939.1623387334507;2959.733623973853;3049.329147587527;3519.595246546629;3526.5944416392185;28803.27991800201;29044.419111617648;29100.8544957276;29237;29751.70248297511;2846.9430611387866;2851.5865199546156;2863.083813179783;2886.163012726307;2912.519434293339;264900;265949;268153;268355;268787.6560617204;52725.472745272054;52954.735226323624;53019;53084.73457632687;53220.46779532233;32556.674433255364;33138.33723325568;33302.833485832416;35272.294554109285;35336.293274134376;14532.27338633064;14743.483978060716;14751.336189871481;14759.852401476062;14763.630909227355;11178;11304.265222760494;11306.830397544043;11307.321560706385;11317.207795454238;15808.340124286784;16099;16185.271662775203;16688.582785430463;18129.909350453163;6507.284198738135;6738.35985581369;6818.761343352959;6875.07809181096;6959.478039147084;835.6197929941862;847.3390755210945;867.9305655547541;870.3168013109679;995.5918073589794;26184.34539136537;26638.866805665846;26838.731612683623;27184.728152718617;27293.454130917667;896.1620884473039;921.5208091792231;992.0823238504355;1009.6567167163053;1026.1893104447404;13692.61279127417;14061.086029408056;14288.214148221947;14317;14547.199904005382;407536;411371;411484;412163;414052;43391;43978.34032489515;47885;48290;48423;1167.4688016952266;1194.9342786146844;1208.6192849252457;1224.3205021212957;1229.3238718704677;27389.178324650293;27976.160715178576;28703.569446457903;28935.7106428933;29112.854435727684;41724.79137604292;42135.7893210532;42188.78905605575;42192.36711449392;42198.78900605477;390190;401131;401561;592768;595059;37695.434568480945;38123.42814857835;38342;38412.2317553653;38927.61072389353;40315.1936961265;40484.79757601193;41002.58997409988;41159.7942010288;41425;35236;35428.29143417066;35432;35532.82233588816;35868.64131358758;35355;35428.114297142776;35859.46210806788;36127.27745445129;36180.81909590435;34710.30579388449;34830.65169348274;35138.824305878305;35158.12104697403;35883;30690.693093069676;32473;32528.674713252563;32786.34427311393;33191;24636.260912172664;24821.751782481944;25013.249602511954;25403.237902862944;25525.87237063803 18:39:00 INFO - PROCESS | 25445 | |2;jquery.html;352.2057759751759;356.5899215901713;368.3425086221095;380.75060835152976;387.61045149624624;12825.935870320647;16074.678506429878;16197.514074577766;16662.83337166628;17318.740218896695;17229.224684889177;17297.48107556772;17344.913275433606;17659;17741.024243666594;4883.8779030524165;4902.289168070628;5055.797768089272;5074.619403544731;5080.872978175538;3701.5002974598488;4951.925721114186;5031.52200540948;5597.944020559803;5919.88160236795;5893.55798315126;5910.940890591082;5911.73397197125;5924.49641780447;5970.701464926758;5041.369828771422;5300.204969254604;5318.6542874713405;5397.352317721859;5936.43603857635;5287.603429742785;5293.841184764463;5295.947040529622;5300.072487314743;5309.920351194735;12514.937425312906;12562.874371256263;12742.36288185587;12836;12867.87132128676;1782.4741701198047;1800.1449311577028;1875.8124187581134;1894.1097684088456;1946.8929208893505;9246.583903724348;9573.856392154123;9704.660336888175;11745.88414100659;12785.61643150707;1700.8132817875437;1756.6047639281187;1762.118940529735;1797.0924683035114;1818.5817262029675;66938;71352;71871;73180;76224.23775762282;10125.696229113139;10197.796044079078;10217.33587316822;10261.230407719451;10693.09108725767;14208.715825683428;14214.502492412716;14237.572872813833;14237.644058898402;14250.928745356206;7378.114626244885;7455.291747283999;7522.623868806647;7550.169481357047;7769.844603107907;6952.270011648805;6970.268121847133;7095.467839912028;7184.994100825888;7204.4956853019785;4088.34586466164;4214.936775948363;4309.762963037063;4393.44262295082;4538.047010127844;1769.8318659727306;1792.9462116136538;1817.1198650139677;1857.637760636663;1886.5095075280526;774.4385320642601;805.4603415711488;808.0747544062134;855.9786005349791;872.358816270041;16180.595485112732;16298.42955496552;16699;16740.58148546296;17131.672526968883;737.5132412607653;819.8032472206746;820.913804050578;826.3059030414481;839.9328053755808;7608.353289970414;9318.114779095975;9588.280878934107;9637.277204209713;9672.129508344282;375741;376323;376880;404426;409442;81056.59471702603;86368.56815716007;86435.56782216049;87381;87859;895.5208963204655;905.4748246017163;932.5803388475214;937.5640327247862;945.9905400946041;15907.920460398087;15911.920440397724;16156.67686646237;16604.252808623398;16792.496225113267;39223.607763921995;39473;40110.79944600258;40150.39774403328;41253.587464124976;56811;56892;57316.71341643265;58209;59088.113678294;7592.39260859141;7654.425918056279;7860.724874629361;7950.960245198737;7979.122296547259;11140.610078647209;11464.197506174487;11491;11596.47815848272;11792.29246245228;9741.512924353896;9956.949661533527;10096;10237.9488102559;10326.690199294033;10435.791284174426;10651.254412191072;10717.678469645924;10752.569897204025;10772.299800512941;9136.26909847224;9663.226941844496;9912.207023438252;9923.851142233018;10068.647597334058;7626.8855967159425;7762.184970578008;7833.412494062854;7872.803179920548;7880.448368614142;8745.912540874764;9568.186704130227;9814.214862810815;10022.3485473444;10108.444035578113 18:39:00 INFO - PROCESS | 25445 | |3;mootools.html;1217.10542751078;1280.6094141286903;1358.7690092684245;1360.387825478535;1663.351292995732;6367.554271201012;7577.318041376275;7786.688532458695;7788.844223115541;7982.521048737065;7698.499597526171;7762.573058481781;7765.339946104588;7771.378289736822;7777.416693747978;2157.5361297321074;2183.170395249811;2183.759786423492;2185.235167691303;2188.627933251343;2130.1692339987417;2160.0819651648067;2209.63541015733;2214.2471559669707;2214.7895949884737;2153.052656830997;2161.4056134563043;2178.270279456384;2178.68409080684;2201.5376770878133;2135.0605733477296;2135.1139277199945;2135.882526461044;2139.8288136949086;2142.1431427428997;2071.2336435518955;2114.38682781993;2115.756687980871;2115.9365219043298;2119.035838693391;7629.465937384385;7711.575863327571;7805.258500442449;7822.139564647884;7848.529088254666;4299.613034826881;4439.733615983019;4562.270036794131;4564.931526027112;4571.382863313476;2746.588011798246;2823.5623478360885;2832.5892745551987;2833.3766571354267;2833.4474777418413;860.165639329849;880.9471431714118;892.8705337725993;905.3617199874072;910.3400034974657;10666.573337066508;10764.569417223302;10842.512086956105;10876.564937402494;10883.891161088446;3954.5649978502342;4130;4215.473065866767;4239.109786944776;4283.357496375568;8318.958405207935;8326.375521835887;8327.458715183493;8335.624896879655;8340.249377555927;4566.74882881438;4567.977160114178;4568.269076947672;4571.291449825282;4581.65637577183;3614.530111085542;4015.9799201004394;4146.751194928314;4181.975416023094;4190.559991200941;3356.2448449099247;3397.6262611112757;3508.6315936826777;3512.4028915084496;3518.1732292911147;1015.1827778638267;1017.872765904262;1033.2302434686208;1037.061459379263;1044.4307852220406;646.890028695123;818.8116733151409;822.5188264865001;833.7832163637377;838.9244967952914;5104.081265372194;5128.948565544055;5146.639735218499;5227.242049902743;5279.788808447696;411.37881798484506;411.7406034198436;414.51915777697724;415.1551592509229;417.6095350846907;3387.796732196027;3405.642407547172;3472.8437220325145;3478.2174010847357;3592.317459682652;9281.814363712689;9662;9754.951225243829;9760.072793084646;9772.16936560386;9682.75793105164;9776.951115244521;9804.215662746963;9818.459984700767;9830.606775729033;7105.467089968273;7176.569405835667;7273.090863642151;7273.8545229095125;7335.706571737071;5102.438731739431;5177.611679124156;5179.093658609653;5232.398274198364;5259.053370393366;8667.393282470419;8825.735227943173;8928.821423571622;8933.240674542736;8968.372213945222;8979.32655050887;8991.100889910957;9082.318826088202;9163.358564900393;9188.816223675623;5689.914651280152;6117.96941015292;6301.6219026858535;6359.395857393541;6361.332060133805;7357.0803649543805;7441.590712510864;7487.101547814297;7546.811329716801;7547.28300811422;6613.603183808987;6692.732290708317;6759.222689390783;6809.421199198124;6946.2011868635755;6669.199696036312;6773.048416403785;6863.450923925974;6945.0624165739;6997.7200911962955;6272.8118156455375;6365.427111559982;6368.77709280173;6407.71165297572;6408.391202835724;4360.760158191203;4492.415985921809;4553.681242313006;4562.452505699337;4647.186742320148;4546.590806827401;4644.37300964379;4650.744209068534;4685.367475390915;4925.655204135676 18:39:00 INFO - PROCESS | 25445 | |4;prototype.html;307.6492798210041;308.4940697256499;315.4448171218655;318.97129258366743;320.3337058917452;4779.091972525222;4789.898323385623;4812.903741925159;4828.179209534379;4828.97585512072;4482.148391805563;4632.351470794091;4643.489216186217;4673.182193116199;4789.856304310868;3711.109333759892;3731.869384571527;3732.3095227382887;3846.1346197105568;3852.4028775539837;3851.8651847185356;3852.6532612064907;3868.70984676149;3876.9612303877025;3895.2014836958497;3615.005873384814;3780.168362960158;3805.676517496016;3831.2912111259366;3852.961470385302;3789.412641040643;3794.620537946211;3800.391937290048;3805.2389522095414;3807.200487897545;3351.095204294851;3353.564036675217;3364.3775901458066;3366.5355570326988;3366.8148251846137;4762.357081793948;4763.951930575268;4765.356676848615;4775.570198682135;4776.617870570381;4128.153728485653;4277.443932288814;4327.545607711177;4329.610335069828;4335.937695264681;5039.21892106724;5040.218766091261;5042.621803364726;5044.419891712427;5045.747712614391;3652.1052342176336;3663.377225871608;3671.9265614687824;3674;3676.1728611062563;5145.279660847485;5294.391145018334;5316;5329.546988505982;5364.785408583652;3694.131879008431;3718.9628103719156;3719.1817800083936;3720.5535335759882;3741.6819570336825;3776.188119554309;3784.6972242220554;3784.8675296365045;3786.072412259014;3788.924221515554;4330.891727706769;4334.219840428753;4337.631301339358;4339.848105316362;4343.218220720238;4921.434035085939;4996.800127994912;4998.275250088716;5074.441811400743;5086.92369614456;1260.5273022616518;1286.9704236610862;1290.148501988683;1291.6383412644475;1291.9612411627666;828.4863384701524;873.1530415496958;886.8137691084816;903.4985583001497;908.7182973278304;4438.090191510732;4442.089371678798;4443.866683999485;4450;4479.619232365286;5150.356205474316;5157.896842063138;5169.922451163236;5212.244224587414;5214.7914083436235;4340.197063543254;4429.955700443019;4433.1577000369825;4458.6878918475395;4482.574155455227;2757.2968892932577;2768.1557125076642;2768.820026698258;2775.3200465885584;2778.930526736807;4843.418789745253;4882.316475693406;4907.576802727241;4908.975455122773;4916.459189489154;5059.721715305694;5283.762230699628;5286.15421532553;5302.549283310885;5304.549113325334;4889.755512224375;4898.608111351084;4910.312556242057;4918.5819205367225;4975.427825800007;5174.353205849269;5225.477452254744;5253.50091741284;5268.973655131853;5280.287161233185;4863.294822250825;5115.411727651368;5144.614153938544;5144.871378215425;5200.739963001759;4911.607071434205;4923.163062279349;4925.1381008324115;4925.655204135676;4931.309616653743;3740.2145549433835;3770.547534295902;3772.6038765929184;3773.415120656303;3782.6028267031566;5048.0156369507595;5191.377034755854;5234.424213336454;5239.895202096013;5252.947470525399;5019.7490125494305;5032.647714659939;5032.874178145429;5044.621653376085;5063.797448102035;5023;5025.396952365593;5053.574284343462;5058.356034288944;5091.236314552847;4852.727317542114;4878.414590249193;4932.383452068491;4960.727160006234;4974.825881094144;4845.854624361275;4927.556519913225;5066.9359434519165;5073.137566613758;5101.617378696538;4977.601791856715;4980.825671101494;4993.925091123563;5000.374953130859;5001.824936127218 18:39:00 INFO - PROCESS | 25445 | |5;yui.html;614.3518587889777;681.6353251010707;703.2440126863623;716.799296197065;718.4396170986629;12867.613971580857;13502.459901603948;13620.795688064687;13637.318134093293;13789.241591712453;13065.869341306585;13105.410256538455;13115.6721081973;13116.803247951288;13124.212547247173;624.7844493649684;756.3533179131846;760.4524742185617;773.7291947818275;774.1523032279645;769.8768197088467;769.8806684963812;769.9114601820806;770.5838847022601;771.3983093187322;833.2001278772356;835.1940377535677;835.2482765511028;835.8370117827026;835.9874601880977;670.1991120610872;784.9332806711465;803.6785285885634;808.6159074439653;813.9796505087361;592.7421571616361;592.751044561281;596.7374355283705;596.7881402102234;597.4145337569206;12492.500299987989;12493.312867792269;12524.624261272176;12526.311052892088;12535.749285014339;12084.456199471046;12166;12458.501659933592;12662;12692.175008624503;9753.561089750978;9897.208223342115;9974.80050398988;10123.088921996981;10593.682189534326;3916.4516967624554;3918.5885482024264;4015.073997354569;4086.693497987663;4092.3656833190903;58647;58823;59179;59772.70113649448;59802.10296845551;9534.28492863038;9724.465154416575;9731.951340243395;9913.306068575275;9923.900760992297;18645.347412840485;18916.432507024536;19092.904535477235;19117.33089341894;19125.80053293861;6640.535162538576;6762.69567869447;6768.323167683192;6785.626790526469;6856.451483881277;3623.6376362363553;3631.654992775682;3656.2504686539196;3770.9434358484646;3799.506064211635;2648.8013398995154;2731.18064580625;2737.6167336572894;2740.438210166911;2741.4380052089273;461.5107985535343;465.23468893669724;467.76377929145565;468.18535747798586;475.5244755244755;512.3272515237752;514.4264145477765;539.6815878631626;551.6607286518762;584.6199970019521;7016.5088443808445;7427.18300986891;7569.356604688553;7750.651220694969;8036.156203598655;491.6018025399438;492.4131713092532;495.48469591625025;542.5442628192337;543.9782408703608;3487.215376540309;3529.27649831789;3559.94660080099;3662.066173125836;3754.0990162360836;108059.45970270099;110367;111237;113610;113966.43016784864;94834;95633;96848.51575742076;98070.50964745131;99277.50361248148;79902;83775.581122094;85006.57496712476;87634.12365876387;90006;7220.819479513054;7267.563946163247;7385.556866588022;7435.851282974419;7551.660175292015;50708.239376408645;51118.48881511137;51570.35866772009;51951.740241298554;52238.47761522488;70223;72568.27431725615;73799;75396;75689.62155189189;8509.87235191485;8718.82562348762;8959.910400896168;9030.090330814079;9223.953880230825;9255.537223138681;9486.857697134687;9597.040295970348;9722.611095556098;10116.949415253172;8434.915650843413;8447.704330348408;8719.564021798758;8854.778630534289;9080.545972701206;8573.657053717781;8646.82706345882;9607.279454040836;9620.278479114235;10004.499775011365;8620.91379086201;8770.12298770118;8797.692080777142;8890.155435233642;8935.240504557185;7648.655810488653;7971.681132754625;8009;8074.341868733216;8252.917470825216;7275.599842008529;7666.808329791576;7866.646000929857;7896.6446509906045;8139.918600814153 18:39:00 INFO - PROCESS | 25445 | __end_tp_report 18:39:00 INFO - PROCESS | 25445 | __start_cc_report 18:39:00 INFO - PROCESS | 25445 | _x_x_mozilla_cycle_collect,1975 18:39:00 INFO - PROCESS | 25445 | __end_cc_report 18:39:00 INFO - PROCESS | 25445 | __startTimestamp1469583540601__endTimestamp 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | ------- Summary: start ------- 18:39:00 INFO - PROCESS | 25445 | Number of tests: 6 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#0] dojo.html Cycles:165 Average:4689.74 Median:4810.95 stddev:483.08 (10.0%) stddev-sans-first:456.15 18:39:00 INFO - PROCESS | 25445 | Values: 2608.7 2609.2 2654.4 2659.7 2680.4 4595.8 4699.5 4721.1 4753.4 4817.9 4697.9 4722.0 4737.7 4750.4 4797.3 4319.2 4368.4 4383.1 4448.7 4459.8 4374.6 4418.1 4435.6 4450.7 4486.7 4506.9 4526.7 4528.8 4547.6 4557.0 4278.4 4314.2 4333.0 4349.5 4379.1 4299.7 4306.7 4309.3 4314.8 4388.7 4759.0 4769.4 4784.8 4791.9 4801.2 4865.0 4955.7 4979.4 4994.7 5047.8 5019.1 5097.8 5101.3 5102.6 5141.6 4778.1 4780.9 4794.9 4803.8 4816.9 5006.9 5093.6 5146.7 5278.8 5285.7 4965.7 4982.0 4988.5 5006.1 5008.8 5027.4 5057.8 5066.6 5084.3 5101.6 4855.3 4901.4 4977.0 4992.6 5006.5 4992.6 5092.3 5103.1 5104.2 5105.5 4295.5 4297.5 4306.5 4333.9 4340.9 3779.2 3784.1 3808.2 3832.1 3867.2 4218.5 4340.4 4366.2 4371.3 4391.9 5147.9 5156.1 5161.1 5163.8 5203.5 4380.7 4411.3 4417.1 4445.6 4459.0 4364.2 4481.6 4490.3 4526.5 4589.7 4757.7 4774.7 4779.2 4811.6 4819.4 5064.1 5075.6 5076.8 5078.4 5079.2 4635.7 4687.5 4690.0 4740.0 4811.0 4953.0 4966.8 4974.0 4978.0 4980.2 4992.3 5042.7 5044.1 5045.2 5047.9 4899.9 4907.3 4915.6 4926.9 4969.5 4989.7 4994.6 4996.0 5020.3 5038.9 4904.8 4923.5 4924.7 4966.4 4966.8 4840.6 4905.4 4907.6 4986.7 5055.8 4747.1 4795.3 4818.3 4862.9 4899.0 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#1] ext.html Cycles:180 Average:52558.11 Median:36154.05 stddev:105941.84 (293.0%) stddev-sans-first:106167.15 18:39:00 INFO - PROCESS | 25445 | Values: 578.5 578.8 581.5 592.5 598.1 26910.6 38211.0 39057.6 39343.8 42897.0 39587.0 39822.0 39858.6 40022.6 40110.6 7191.4 7655.5 7738.2 7788.9 7799.3 7238.7 7475.0 7477.7 9662.8 9887.7 9988.9 10045.9 10048.9 10049.8 10082.8 9871.6 9952.0 9958.4 9959.5 9963.7 9417.4 9474.8 9476.4 9478.8 9479.1 38428.0 38646.6 38737.8 38750.0 38860.8 2939.2 2959.7 3049.3 3519.6 3526.6 28803.3 29044.4 29100.9 29237.0 29751.7 2846.9 2851.6 2863.1 2886.2 2912.5 264900.0 265949.0 268153.0 268355.0 268787.7 52725.5 52954.7 53019.0 53084.7 53220.5 32556.7 33138.3 33302.8 35272.3 35336.3 14532.3 14743.5 14751.3 14759.9 14763.6 11178.0 11304.3 11306.8 11307.3 11317.2 15808.3 16099.0 16185.3 16688.6 18129.9 6507.3 6738.4 6818.8 6875.1 6959.5 835.6 847.3 867.9 870.3 995.6 26184.3 26638.9 26838.7 27184.7 27293.5 896.2 921.5 992.1 1009.7 1026.2 13692.6 14061.1 14288.2 14317.0 14547.2 407536.0 411371.0 411484.0 412163.0 414052.0 43391.0 43978.3 47885.0 48290.0 48423.0 1167.5 1194.9 1208.6 1224.3 1229.3 27389.2 27976.2 28703.6 28935.7 29112.9 41724.8 42135.8 42188.8 42192.4 42198.8 390190.0 401131.0 401561.0 592768.0 595059.0 37695.4 38123.4 38342.0 38412.2 38927.6 40315.2 40484.8 41002.6 41159.8 41425.0 35236.0 35428.3 35432.0 35532.8 35868.6 35355.0 35428.1 35859.5 36127.3 36180.8 34710.3 34830.7 35138.8 35158.1 35883.0 30690.7 32473.0 32528.7 32786.3 33191.0 24636.3 24821.8 25013.2 25403.2 25525.9 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#2] jquery.html Cycles:180 Average:24676.58 Median:4927.11 stddev:64616.27 (1311.4%) stddev-sans-first:64771.72 18:39:00 INFO - PROCESS | 25445 | Values: 352.2 356.6 368.3 380.8 387.6 12825.9 16074.7 16197.5 16662.8 17318.7 17229.2 17297.5 17344.9 17659.0 17741.0 4883.9 4902.3 5055.8 5074.6 5080.9 3701.5 4951.9 5031.5 5597.9 5919.9 5893.6 5910.9 5911.7 5924.5 5970.7 5041.4 5300.2 5318.7 5397.4 5936.4 5287.6 5293.8 5295.9 5300.1 5309.9 12514.9 12562.9 12742.4 12836.0 12867.9 1782.5 1800.1 1875.8 1894.1 1946.9 9246.6 9573.9 9704.7 11745.9 12785.6 1700.8 1756.6 1762.1 1797.1 1818.6 66938.0 71352.0 71871.0 73180.0 76224.2 10125.7 10197.8 10217.3 10261.2 10693.1 14208.7 14214.5 14237.6 14237.6 14250.9 7378.1 7455.3 7522.6 7550.2 7769.8 6952.3 6970.3 7095.5 7185.0 7204.5 4088.3 4214.9 4309.8 4393.4 4538.0 1769.8 1792.9 1817.1 1857.6 1886.5 774.4 805.5 808.1 856.0 872.4 16180.6 16298.4 16699.0 16740.6 17131.7 737.5 819.8 820.9 826.3 839.9 7608.4 9318.1 9588.3 9637.3 9672.1 375741.0 376323.0 376880.0 404426.0 409442.0 81056.6 86368.6 86435.6 87381.0 87859.0 895.5 905.5 932.6 937.6 946.0 15907.9 15911.9 16156.7 16604.3 16792.5 39223.6 39473.0 40110.8 40150.4 41253.6 56811.0 56892.0 57316.7 58209.0 59088.1 7592.4 7654.4 7860.7 7951.0 7979.1 11140.6 11464.2 11491.0 11596.5 11792.3 9741.5 9956.9 10096.0 10237.9 10326.7 10435.8 10651.3 10717.7 10752.6 10772.3 9136.3 9663.2 9912.2 9923.9 10068.6 7626.9 7762.2 7833.4 7872.8 7880.4 8745.9 9568.2 9814.2 10022.3 10108.4 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#3] mootools.html Cycles:180 Average:5062.35 Median:5103.26 stddev:2897.96 (56.8%) stddev-sans-first:2891.68 18:39:00 INFO - PROCESS | 25445 | Values: 1217.1 1280.6 1358.8 1360.4 1663.4 6367.6 7577.3 7786.7 7788.8 7982.5 7698.5 7762.6 7765.3 7771.4 7777.4 2157.5 2183.2 2183.8 2185.2 2188.6 2130.2 2160.1 2209.6 2214.2 2214.8 2153.1 2161.4 2178.3 2178.7 2201.5 2135.1 2135.1 2135.9 2139.8 2142.1 2071.2 2114.4 2115.8 2115.9 2119.0 7629.5 7711.6 7805.3 7822.1 7848.5 4299.6 4439.7 4562.3 4564.9 4571.4 2746.6 2823.6 2832.6 2833.4 2833.4 860.2 880.9 892.9 905.4 910.3 10666.6 10764.6 10842.5 10876.6 10883.9 3954.6 4130.0 4215.5 4239.1 4283.4 8319.0 8326.4 8327.5 8335.6 8340.2 4566.7 4568.0 4568.3 4571.3 4581.7 3614.5 4016.0 4146.8 4182.0 4190.6 3356.2 3397.6 3508.6 3512.4 3518.2 1015.2 1017.9 1033.2 1037.1 1044.4 646.9 818.8 822.5 833.8 838.9 5104.1 5128.9 5146.6 5227.2 5279.8 411.4 411.7 414.5 415.2 417.6 3387.8 3405.6 3472.8 3478.2 3592.3 9281.8 9662.0 9755.0 9760.1 9772.2 9682.8 9777.0 9804.2 9818.5 9830.6 7105.5 7176.6 7273.1 7273.9 7335.7 5102.4 5177.6 5179.1 5232.4 5259.1 8667.4 8825.7 8928.8 8933.2 8968.4 8979.3 8991.1 9082.3 9163.4 9188.8 5689.9 6118.0 6301.6 6359.4 6361.3 7357.1 7441.6 7487.1 7546.8 7547.3 6613.6 6692.7 6759.2 6809.4 6946.2 6669.2 6773.0 6863.5 6945.1 6997.7 6272.8 6365.4 6368.8 6407.7 6408.4 4360.8 4492.4 4553.7 4562.5 4647.2 4546.6 4644.4 4650.7 4685.4 4925.7 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#4] prototype.html Cycles:180 Average:4209.04 Median:4789.88 stddev:1207.70 (25.2%) stddev-sans-first:1175.05 18:39:00 INFO - PROCESS | 25445 | Values: 307.6 308.5 315.4 319.0 320.3 4779.1 4789.9 4812.9 4828.2 4829.0 4482.1 4632.4 4643.5 4673.2 4789.9 3711.1 3731.9 3732.3 3846.1 3852.4 3851.9 3852.7 3868.7 3877.0 3895.2 3615.0 3780.2 3805.7 3831.3 3853.0 3789.4 3794.6 3800.4 3805.2 3807.2 3351.1 3353.6 3364.4 3366.5 3366.8 4762.4 4764.0 4765.4 4775.6 4776.6 4128.2 4277.4 4327.5 4329.6 4335.9 5039.2 5040.2 5042.6 5044.4 5045.7 3652.1 3663.4 3671.9 3674.0 3676.2 5145.3 5294.4 5316.0 5329.5 5364.8 3694.1 3719.0 3719.2 3720.6 3741.7 3776.2 3784.7 3784.9 3786.1 3788.9 4330.9 4334.2 4337.6 4339.8 4343.2 4921.4 4996.8 4998.3 5074.4 5086.9 1260.5 1287.0 1290.1 1291.6 1292.0 828.5 873.2 886.8 903.5 908.7 4438.1 4442.1 4443.9 4450.0 4479.6 5150.4 5157.9 5169.9 5212.2 5214.8 4340.2 4430.0 4433.2 4458.7 4482.6 2757.3 2768.2 2768.8 2775.3 2778.9 4843.4 4882.3 4907.6 4909.0 4916.5 5059.7 5283.8 5286.2 5302.5 5304.5 4889.8 4898.6 4910.3 4918.6 4975.4 5174.4 5225.5 5253.5 5269.0 5280.3 4863.3 5115.4 5144.6 5144.9 5200.7 4911.6 4923.2 4925.1 4925.7 4931.3 3740.2 3770.5 3772.6 3773.4 3782.6 5048.0 5191.4 5234.4 5239.9 5252.9 5019.7 5032.6 5032.9 5044.6 5063.8 5023.0 5025.4 5053.6 5058.4 5091.2 4852.7 4878.4 4932.4 4960.7 4974.8 4845.9 4927.6 5066.9 5073.1 5101.6 4977.6 4980.8 4993.9 5000.4 5001.8 18:39:00 INFO - PROCESS | 25445 | 18:39:00 INFO - PROCESS | 25445 | [#5] yui.html Cycles:180 Average:18638.81 Median:3733.63 stddev:29017.72 (777.2%) stddev-sans-first:29067.56 18:39:00 INFO - PROCESS | 25445 | Values: 614.4 681.6 703.2 716.8 718.4 12867.6 13502.5 13620.8 13637.3 13789.2 13065.9 13105.4 13115.7 13116.8 13124.2 624.8 756.4 760.5 773.7 774.2 769.9 769.9 769.9 770.6 771.4 833.2 835.2 835.2 835.8 836.0 670.2 784.9 803.7 808.6 814.0 592.7 592.8 596.7 596.8 597.4 12492.5 12493.3 12524.6 12526.3 12535.7 12084.5 12166.0 12458.5 12662.0 12692.2 9753.6 9897.2 9974.8 10123.1 10593.7 3916.5 3918.6 4015.1 4086.7 4092.4 58647.0 58823.0 59179.0 59772.7 59802.1 9534.3 9724.5 9732.0 9913.3 9923.9 18645.3 18916.4 19092.9 19117.3 19125.8 6640.5 6762.7 6768.3 6785.6 6856.5 3623.6 3631.7 3656.3 3770.9 3799.5 2648.8 2731.2 2737.6 2740.4 2741.4 461.5 465.2 467.8 468.2 475.5 512.3 514.4 539.7 551.7 584.6 7016.5 7427.2 7569.4 7750.7 8036.2 491.6 492.4 495.5 542.5 544.0 3487.2 3529.3 3559.9 3662.1 3754.1 108059.5 110367.0 111237.0 113610.0 113966.4 94834.0 95633.0 96848.5 98070.5 99277.5 79902.0 83775.6 85006.6 87634.1 90006.0 7220.8 7267.6 7385.6 7435.9 7551.7 50708.2 51118.5 51570.4 51951.7 52238.5 70223.0 72568.3 73799.0 75396.0 75689.6 8509.9 8718.8 8959.9 9030.1 9224.0 9255.5 9486.9 9597.0 9722.6 10116.9 8434.9 8447.7 8719.6 8854.8 9080.5 8573.7 8646.8 9607.3 9620.3 10004.5 8620.9 8770.1 8797.7 8890.2 8935.2 7648.7 7971.7 8009.0 8074.3 8252.9 7275.6 7666.8 7866.6 7896.6 8139.9 18:39:00 INFO - PROCESS | 25445 | -------- Summary: end -------- 18:39:00 INFO - PROCESS | 25445 | 18:39:01 INFO - TEST-INFO | 25445: exit 0 18:39:01 INFO - TEST-OK | dromaeo_css | took 1120760ms 18:39:01 INFO - TEST-START | kraken 18:39:01 INFO - operating with platform_type : linux_ 18:39:01 INFO - Initialising browser for kraken test... 18:39:01 INFO - TEST-INFO | started process 25630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlIxel/profile http://localhost:52285/getInfo.html) 18:39:04 INFO - PROCESS | 25630 | JavaScript error: , line 0: uncaught exception: undefined 18:39:05 INFO - PROCESS | 25630 | __metrics Screen width/height:1600/1200 18:39:05 INFO - PROCESS | 25630 | colorDepth:24 18:39:05 INFO - PROCESS | 25630 | Browser inner width/height: 1024/697 18:39:05 INFO - PROCESS | 25630 | __metrics 18:39:06 INFO - PROCESS | 25630 | 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" 18:39:06 INFO - PROCESS | 25630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:39:07 INFO - TEST-INFO | 25630: exit 0 18:39:07 INFO - Browser initialized. 18:39:07 INFO - Running cycle 1/1 for kraken test... 18:39:07 INFO - TEST-INFO | started process 25710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMlIxel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:19 INFO - PROCESS | 25710 | RSS: Main: 159862784 18:39:19 INFO - PROCESS | 25710 | 18:39:22 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-beat-detection) 18:39:23 INFO - PROCESS | 25710 | RSS: Main: 215801856 18:39:23 INFO - PROCESS | 25710 | 18:39:26 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-dft) 18:39:26 INFO - PROCESS | 25710 | RSS: Main: 193073152 18:39:26 INFO - PROCESS | 25710 | 18:39:29 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-fft) 18:39:30 INFO - PROCESS | 25710 | RSS: Main: 273981440 18:39:30 INFO - PROCESS | 25710 | 18:39:32 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-oscillator) 18:39:33 INFO - PROCESS | 25710 | RSS: Main: 182263808 18:39:33 INFO - PROCESS | 25710 | 18:39:35 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:39:36 INFO - PROCESS | 25710 | RSS: Main: 186724352 18:39:36 INFO - PROCESS | 25710 | 18:39:39 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:39 INFO - PROCESS | 25710 | RSS: Main: 223232000 18:39:39 INFO - PROCESS | 25710 | 18:39:43 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-desaturate) 18:39:44 INFO - PROCESS | 25710 | RSS: Main: 222830592 18:39:44 INFO - PROCESS | 25710 | 18:39:46 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52285/tests/kraken/driver.html?testName=json-parse-financial) 18:39:47 INFO - PROCESS | 25710 | RSS: Main: 221868032 18:39:47 INFO - PROCESS | 25710 | 18:39:49 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:49 INFO - PROCESS | 25710 | RSS: Main: 187039744 18:39:49 INFO - PROCESS | 25710 | 18:39:51 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:52 INFO - PROCESS | 25710 | RSS: Main: 194011136 18:39:52 INFO - PROCESS | 25710 | 18:39:54 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:55 INFO - PROCESS | 25710 | RSS: Main: 196173824 18:39:55 INFO - PROCESS | 25710 | 18:39:57 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:58 INFO - PROCESS | 25710 | RSS: Main: 191483904 18:39:58 INFO - PROCESS | 25710 | 18:40:01 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:02 INFO - PROCESS | 25710 | RSS: Main: 194809856 18:40:02 INFO - PROCESS | 25710 | 18:40:03 INFO - PROCESS | 25710 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52285/tests/kraken/driver.html?testName=ai-astar) 18:40:04 INFO - PROCESS | 25710 | RSS: Main: 245374976 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | __start_tp_report 18:40:04 INFO - PROCESS | 25710 | _x_x_mozilla_page_load 18:40:04 INFO - PROCESS | 25710 | _x_x_mozilla_page_load_details 18:40:04 INFO - PROCESS | 25710 | |i|pagename|runs| 18:40:04 INFO - PROCESS | 25710 | |0;ai-astar;104;114;113;113;113;112;114;113;112;114 18:40:04 INFO - PROCESS | 25710 | |1;audio-beat-detection;153;120;125;196;125;122;155;121;165;122 18:40:04 INFO - PROCESS | 25710 | |2;audio-dft;162;161;161;160;162;162;162;161;161;161 18:40:04 INFO - PROCESS | 25710 | |3;audio-fft;75;79;76;125;75;76;77;76;101;75 18:40:04 INFO - PROCESS | 25710 | |4;audio-oscillator;86;86;116;85;86;85;131;84;85;124 18:40:04 INFO - PROCESS | 25710 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;118;117;116 18:40:04 INFO - PROCESS | 25710 | |6;imaging-darkroom;146;147;146;147;146;147;146;146;146;146 18:40:04 INFO - PROCESS | 25710 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;96;94 18:40:04 INFO - PROCESS | 25710 | |8;json-parse-financial;63;62;62;62;63;63;64;62;63;62 18:40:04 INFO - PROCESS | 25710 | |9;json-stringify-tinderbox;65;66;66;65;66;66;65;66;66;65 18:40:04 INFO - PROCESS | 25710 | |10;stanford-crypto-aes;87;80;79;80;91;81;80;79;79;84 18:40:04 INFO - PROCESS | 25710 | |11;stanford-crypto-ccm;130;131;128;129;129;127;134;127;172;140 18:40:04 INFO - PROCESS | 25710 | |12;stanford-crypto-pbkdf2;164;163;165;166;163;166;163;165;166;166 18:40:04 INFO - PROCESS | 25710 | |13;stanford-crypto-sha256-iterative;67;66;72;66;66;66;67;70;66;66 18:40:04 INFO - PROCESS | 25710 | __end_tp_report 18:40:04 INFO - PROCESS | 25710 | __start_cc_report 18:40:04 INFO - PROCESS | 25710 | _x_x_mozilla_cycle_collect,1947 18:40:04 INFO - PROCESS | 25710 | __end_cc_report 18:40:04 INFO - PROCESS | 25710 | __startTimestamp1469583604060__endTimestamp 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | ------- Summary: start ------- 18:40:04 INFO - PROCESS | 25710 | Number of tests: 14 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.97 (2.6%) stddev-sans-first:0.78 18:40:04 INFO - PROCESS | 25710 | Values: 104.0 114.0 113.0 113.0 113.0 112.0 114.0 113.0 112.0 114.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:139.00 stddev:25.85 (18.6%) stddev-sans-first:27.01 18:40:04 INFO - PROCESS | 25710 | Values: 153.0 120.0 125.0 196.0 125.0 122.0 155.0 121.0 165.0 122.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 18:40:04 INFO - PROCESS | 25710 | Values: 162.0 161.0 161.0 160.0 162.0 162.0 162.0 161.0 161.0 161.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.59 (21.8%) stddev-sans-first:17.31 18:40:04 INFO - PROCESS | 25710 | Values: 75.0 79.0 76.0 125.0 75.0 76.0 77.0 76.0 101.0 75.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:85.00 stddev:18.88 (22.2%) stddev-sans-first:19.62 18:40:04 INFO - PROCESS | 25710 | Values: 86.0 86.0 116.0 85.0 86.0 85.0 131.0 84.0 85.0 124.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:40:04 INFO - PROCESS | 25710 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 18:40:04 INFO - PROCESS | 25710 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:40:04 INFO - PROCESS | 25710 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 18:40:04 INFO - PROCESS | 25710 | Values: 63.0 62.0 62.0 62.0 63.0 63.0 64.0 62.0 63.0 62.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 18:40:04 INFO - PROCESS | 25710 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 65.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:80.50 stddev:4.08 (5.1%) stddev-sans-first:3.91 18:40:04 INFO - PROCESS | 25710 | Values: 87.0 80.0 79.0 80.0 91.0 81.0 80.0 79.0 79.0 84.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:130.50 stddev:13.68 (10.5%) stddev-sans-first:14.40 18:40:04 INFO - PROCESS | 25710 | Values: 130.0 131.0 128.0 129.0 129.0 127.0 134.0 127.0 172.0 140.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:1.34 (0.8%) stddev-sans-first:1.39 18:40:04 INFO - PROCESS | 25710 | Values: 164.0 163.0 165.0 166.0 163.0 166.0 163.0 165.0 166.0 166.0 18:40:04 INFO - PROCESS | 25710 | 18:40:04 INFO - PROCESS | 25710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.50 stddev:2.10 (3.2%) stddev-sans-first:2.22 18:40:04 INFO - PROCESS | 25710 | Values: 67.0 66.0 72.0 66.0 66.0 66.0 67.0 70.0 66.0 66.0 18:40:04 INFO - PROCESS | 25710 | -------- Summary: end -------- 18:40:04 INFO - PROCESS | 25710 | 18:40:05 INFO - TEST-INFO | 25710: exit 0 18:40:05 INFO - TEST-OK | kraken | took 63778ms 18:40:05 INFO - SUITE-END | took 1184s 18:40:05 INFO - Completed test suite (00:19:44) 18:40:05 INFO - javascript benchmark 18:40:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.6608740863685, 2609.2172348295508, 2654.416028473735, 2659.6808382994036, 2680.3701130234404, 4595.770211489429, 4699.459562150354, 4721.055788842233, 4753.382060332161, 4817.855464336071, 4697.882552936178, 4721.952780472194, 4737.715737055779, 4750.429948406196, 4797.304390863332, 4319.157764235975, 4368.366586844905, 4383.079553293812, 4448.710833795809, 4459.821607135711, 4374.60628543431, 4418.072204836972, 4435.645148388121, 4450.710703804242, 4486.7083639563325, 4506.909861802762, 4526.6831321807485, 4528.773561321937, 4547.567981041796, 4556.97721511392, 4278.379634952915, 4314.245007123772, 4333.0, 4349.456317960255, 4379.0585024219945, 4299.72051816634, 4306.74159550428, 4309.332053531708, 4314.784260786948, 4388.7147335423415, 4758.976205118987, 4769.35613692154, 4784.832530861403, 4791.880202994918, 4801.231802911518, 4864.975675121637, 4955.653104282702, 4979.352684151074, 4994.650374473788, 5047.798088076473, 5019.071471777733, 5097.847064588068, 5101.2603172539775, 5102.566281866046, 5141.562967147797, 4778.1399348116975, 4780.928286075712, 4794.880127996828, 4803.759812009455, 4816.903661926742, 5006.924896126561, 5093.643444958817, 5146.742662866842, 5278.815241466607, 5285.735713214324, 4965.702057876539, 4982.0, 4988.5260900214425, 5006.123928312531, 5008.824691135793, 5027.396712394536, 5057.822976195889, 5066.645334826527, 5084.313617661643, 5101.617378696613, 4855.32025516428, 4901.436334821541, 4976.954839483677, 4992.600591952635, 5006.4743201964, 4992.600591952635, 5092.337996060563, 5103.081445339801, 5104.2088476286235, 5105.463926287686, 4295.484541854935, 4297.484301883732, 4306.4832220133785, 4333.891652708708, 4340.934885976713, 3779.168582911755, 3784.0918179636687, 3808.2383523295453, 3832.0994566276904, 3867.187890542961, 4218.535961044283, 4340.435743353407, 4366.214081465367, 4371.256886329332, 4391.890202744893, 5147.897042059138, 5156.123459011977, 5161.096808058574, 5163.793448262102, 5203.505666961632, 4380.671449641226, 4411.250087485135, 4417.116576684676, 4445.59989600931, 4458.955410445854, 4364.192624364503, 4481.641468682497, 4490.348899409567, 4526.456825180933, 4589.65577581676, 4757.666963312535, 4774.737389443614, 4779.1636463619425, 4811.566958973709, 4819.397575303087, 5064.088464076502, 5075.6193285502995, 5076.771545280545, 5078.390593128848, 5079.187330027178, 4635.65232607549, 4687.460941991714, 4689.953100469088, 4739.976300118477, 4810.95189048105, 4952.975235123801, 4966.776495057803, 4973.9751301244705, 4977.9751101244265, 4980.203167493184, 4992.326035985096, 5042.697438153723, 5044.117279476003, 5045.2432135180015, 5047.87380315495, 4899.902001960012, 4907.337509436323, 4915.582175515121, 4926.852194434173, 4969.4782047884455, 4989.725565093955, 4994.625403094709, 4996.000799839974, 5020.297158397901, 5038.924416133834, 4904.803807847788, 4923.532264434873, 4924.704517728947, 4966.404031516241, 4966.751662416937, 4840.6127509799835, 4905.386826646669, 4907.5828554571835, 4986.650934434555, 5055.772490237875, 4747.050589881968, 4795.2567352059095, 4818.325434439252, 4862.878428039327, 4899.0], "value": 4659.1767828629345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.482258378751, 578.8263520943716, 581.5260562641449, 592.5437413191845, 598.1088178613863, 26910.5963410549, 38211.0, 39057.60942390575, 39343.80328098363, 42897.0, 39587.0, 39822.0, 39858.60141398585, 40022.59977400225, 40110.598894011055, 7191.38873195779, 7655.46411751179, 7738.226177382273, 7788.883166752503, 7799.298063174313, 7238.71045158193, 7474.990876231721, 7477.6635051422545, 9662.758431039245, 9887.653932112378, 9988.850167247498, 10045.949770251138, 10048.899511004869, 10049.799004019915, 10082.848757268646, 9871.555779989918, 9951.950240248789, 9958.402495850272, 9959.502024898726, 9963.65127220551, 9417.387869788441, 9474.763130921714, 9476.431414115106, 9478.763030924212, 9479.052094790535, 38428.0, 38646.61353386458, 38737.806310968546, 38750.0, 38860.805695971336, 2939.1623387334507, 2959.733623973853, 3049.329147587527, 3519.595246546629, 3526.5944416392185, 28803.27991800201, 29044.419111617648, 29100.8544957276, 29237.0, 29751.70248297511, 2846.9430611387866, 2851.5865199546156, 2863.083813179783, 2886.163012726307, 2912.519434293339, 264900.0, 265949.0, 268153.0, 268355.0, 268787.6560617204, 52725.472745272054, 52954.735226323624, 53019.0, 53084.73457632687, 53220.46779532233, 32556.674433255364, 33138.33723325568, 33302.833485832416, 35272.294554109285, 35336.293274134376, 14532.27338633064, 14743.483978060716, 14751.336189871481, 14759.852401476062, 14763.630909227355, 11178.0, 11304.265222760494, 11306.830397544043, 11307.321560706385, 11317.207795454238, 15808.340124286784, 16099.0, 16185.271662775203, 16688.582785430463, 18129.909350453163, 6507.284198738135, 6738.35985581369, 6818.761343352959, 6875.07809181096, 6959.478039147084, 835.6197929941862, 847.3390755210945, 867.9305655547541, 870.3168013109679, 995.5918073589794, 26184.34539136537, 26638.866805665846, 26838.731612683623, 27184.728152718617, 27293.454130917667, 896.1620884473039, 921.5208091792231, 992.0823238504355, 1009.6567167163053, 1026.1893104447404, 13692.61279127417, 14061.086029408056, 14288.214148221947, 14317.0, 14547.199904005382, 407536.0, 411371.0, 411484.0, 412163.0, 414052.0, 43391.0, 43978.34032489515, 47885.0, 48290.0, 48423.0, 1167.4688016952266, 1194.9342786146844, 1208.6192849252457, 1224.3205021212957, 1229.3238718704677, 27389.178324650293, 27976.160715178576, 28703.569446457903, 28935.7106428933, 29112.854435727684, 41724.79137604292, 42135.7893210532, 42188.78905605575, 42192.36711449392, 42198.78900605477, 390190.0, 401131.0, 401561.0, 592768.0, 595059.0, 37695.434568480945, 38123.42814857835, 38342.0, 38412.2317553653, 38927.61072389353, 40315.1936961265, 40484.79757601193, 41002.58997409988, 41159.7942010288, 41425.0, 35236.0, 35428.29143417066, 35432.0, 35532.82233588816, 35868.64131358758, 35355.0, 35428.114297142776, 35859.46210806788, 36127.27745445129, 36180.81909590435, 34710.30579388449, 34830.65169348274, 35138.824305878305, 35158.12104697403, 35883.0, 30690.693093069676, 32473.0, 32528.674713252563, 32786.34427311393, 33191.0, 24636.260912172664, 24821.751782481944, 25013.249602511954, 25403.237902862944, 25525.87237063803], "value": 17867.14466478729, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2057759751759, 356.5899215901713, 368.3425086221095, 380.75060835152976, 387.61045149624624, 12825.935870320647, 16074.678506429878, 16197.514074577766, 16662.83337166628, 17318.740218896695, 17229.224684889177, 17297.48107556772, 17344.913275433606, 17659.0, 17741.024243666594, 4883.8779030524165, 4902.289168070628, 5055.797768089272, 5074.619403544731, 5080.872978175538, 3701.5002974598488, 4951.925721114186, 5031.52200540948, 5597.944020559803, 5919.88160236795, 5893.55798315126, 5910.940890591082, 5911.73397197125, 5924.49641780447, 5970.701464926758, 5041.369828771422, 5300.204969254604, 5318.6542874713405, 5397.352317721859, 5936.43603857635, 5287.603429742785, 5293.841184764463, 5295.947040529622, 5300.072487314743, 5309.920351194735, 12514.937425312906, 12562.874371256263, 12742.36288185587, 12836.0, 12867.87132128676, 1782.4741701198047, 1800.1449311577028, 1875.8124187581134, 1894.1097684088456, 1946.8929208893505, 9246.583903724348, 9573.856392154123, 9704.660336888175, 11745.88414100659, 12785.61643150707, 1700.8132817875437, 1756.6047639281187, 1762.118940529735, 1797.0924683035114, 1818.5817262029675, 66938.0, 71352.0, 71871.0, 73180.0, 76224.23775762282, 10125.696229113139, 10197.796044079078, 10217.33587316822, 10261.230407719451, 10693.09108725767, 14208.715825683428, 14214.502492412716, 14237.572872813833, 14237.644058898402, 14250.928745356206, 7378.114626244885, 7455.291747283999, 7522.623868806647, 7550.169481357047, 7769.844603107907, 6952.270011648805, 6970.268121847133, 7095.467839912028, 7184.994100825888, 7204.4956853019785, 4088.34586466164, 4214.936775948363, 4309.762963037063, 4393.44262295082, 4538.047010127844, 1769.8318659727306, 1792.9462116136538, 1817.1198650139677, 1857.637760636663, 1886.5095075280526, 774.4385320642601, 805.4603415711488, 808.0747544062134, 855.9786005349791, 872.358816270041, 16180.595485112732, 16298.42955496552, 16699.0, 16740.58148546296, 17131.672526968883, 737.5132412607653, 819.8032472206746, 820.913804050578, 826.3059030414481, 839.9328053755808, 7608.353289970414, 9318.114779095975, 9588.280878934107, 9637.277204209713, 9672.129508344282, 375741.0, 376323.0, 376880.0, 404426.0, 409442.0, 81056.59471702603, 86368.56815716007, 86435.56782216049, 87381.0, 87859.0, 895.5208963204655, 905.4748246017163, 932.5803388475214, 937.5640327247862, 945.9905400946041, 15907.920460398087, 15911.920440397724, 16156.67686646237, 16604.252808623398, 16792.496225113267, 39223.607763921995, 39473.0, 40110.79944600258, 40150.39774403328, 41253.587464124976, 56811.0, 56892.0, 57316.71341643265, 58209.0, 59088.113678294, 7592.39260859141, 7654.425918056279, 7860.724874629361, 7950.960245198737, 7979.122296547259, 11140.610078647209, 11464.197506174487, 11491.0, 11596.47815848272, 11792.29246245228, 9741.512924353896, 9956.949661533527, 10096.0, 10237.9488102559, 10326.690199294033, 10435.791284174426, 10651.254412191072, 10717.678469645924, 10752.569897204025, 10772.299800512941, 9136.26909847224, 9663.226941844496, 9912.207023438252, 9923.851142233018, 10068.647597334058, 7626.8855967159425, 7762.184970578008, 7833.412494062854, 7872.803179920548, 7880.448368614142, 8745.912540874764, 9568.186704130227, 9814.214862810815, 10022.3485473444, 10108.444035578113], "value": 8176.181055992892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.10542751078, 1280.6094141286903, 1358.7690092684245, 1360.387825478535, 1663.351292995732, 6367.554271201012, 7577.318041376275, 7786.688532458695, 7788.844223115541, 7982.521048737065, 7698.499597526171, 7762.573058481781, 7765.339946104588, 7771.378289736822, 7777.416693747978, 2157.5361297321074, 2183.170395249811, 2183.759786423492, 2185.235167691303, 2188.627933251343, 2130.1692339987417, 2160.0819651648067, 2209.63541015733, 2214.2471559669707, 2214.7895949884737, 2153.052656830997, 2161.4056134563043, 2178.270279456384, 2178.68409080684, 2201.5376770878133, 2135.0605733477296, 2135.1139277199945, 2135.882526461044, 2139.8288136949086, 2142.1431427428997, 2071.2336435518955, 2114.38682781993, 2115.756687980871, 2115.9365219043298, 2119.035838693391, 7629.465937384385, 7711.575863327571, 7805.258500442449, 7822.139564647884, 7848.529088254666, 4299.613034826881, 4439.733615983019, 4562.270036794131, 4564.931526027112, 4571.382863313476, 2746.588011798246, 2823.5623478360885, 2832.5892745551987, 2833.3766571354267, 2833.4474777418413, 860.165639329849, 880.9471431714118, 892.8705337725993, 905.3617199874072, 910.3400034974657, 10666.573337066508, 10764.569417223302, 10842.512086956105, 10876.564937402494, 10883.891161088446, 3954.5649978502342, 4130.0, 4215.473065866767, 4239.109786944776, 4283.357496375568, 8318.958405207935, 8326.375521835887, 8327.458715183493, 8335.624896879655, 8340.249377555927, 4566.74882881438, 4567.977160114178, 4568.269076947672, 4571.291449825282, 4581.65637577183, 3614.530111085542, 4015.9799201004394, 4146.751194928314, 4181.975416023094, 4190.559991200941, 3356.2448449099247, 3397.6262611112757, 3508.6315936826777, 3512.4028915084496, 3518.1732292911147, 1015.1827778638267, 1017.872765904262, 1033.2302434686208, 1037.061459379263, 1044.4307852220406, 646.890028695123, 818.8116733151409, 822.5188264865001, 833.7832163637377, 838.9244967952914, 5104.081265372194, 5128.948565544055, 5146.639735218499, 5227.242049902743, 5279.788808447696, 411.37881798484506, 411.7406034198436, 414.51915777697724, 415.1551592509229, 417.6095350846907, 3387.796732196027, 3405.642407547172, 3472.8437220325145, 3478.2174010847357, 3592.317459682652, 9281.814363712689, 9662.0, 9754.951225243829, 9760.072793084646, 9772.16936560386, 9682.75793105164, 9776.951115244521, 9804.215662746963, 9818.459984700767, 9830.606775729033, 7105.467089968273, 7176.569405835667, 7273.090863642151, 7273.8545229095125, 7335.706571737071, 5102.438731739431, 5177.611679124156, 5179.093658609653, 5232.398274198364, 5259.053370393366, 8667.393282470419, 8825.735227943173, 8928.821423571622, 8933.240674542736, 8968.372213945222, 8979.32655050887, 8991.100889910957, 9082.318826088202, 9163.358564900393, 9188.816223675623, 5689.914651280152, 6117.96941015292, 6301.6219026858535, 6359.395857393541, 6361.332060133805, 7357.0803649543805, 7441.590712510864, 7487.101547814297, 7546.811329716801, 7547.28300811422, 6613.603183808987, 6692.732290708317, 6759.222689390783, 6809.421199198124, 6946.2011868635755, 6669.199696036312, 6773.048416403785, 6863.450923925974, 6945.0624165739, 6997.7200911962955, 6272.8118156455375, 6365.427111559982, 6368.77709280173, 6407.71165297572, 6408.391202835724, 4360.760158191203, 4492.415985921809, 4553.681242313006, 4562.452505699337, 4647.186742320148, 4546.590806827401, 4644.37300964379, 4650.744209068534, 4685.367475390915, 4925.655204135676], "value": 3978.7482480020744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.6492798210041, 308.4940697256499, 315.4448171218655, 318.97129258366743, 320.3337058917452, 4779.091972525222, 4789.898323385623, 4812.903741925159, 4828.179209534379, 4828.97585512072, 4482.148391805563, 4632.351470794091, 4643.489216186217, 4673.182193116199, 4789.856304310868, 3711.109333759892, 3731.869384571527, 3732.3095227382887, 3846.1346197105568, 3852.4028775539837, 3851.8651847185356, 3852.6532612064907, 3868.70984676149, 3876.9612303877025, 3895.2014836958497, 3615.005873384814, 3780.168362960158, 3805.676517496016, 3831.2912111259366, 3852.961470385302, 3789.412641040643, 3794.620537946211, 3800.391937290048, 3805.2389522095414, 3807.200487897545, 3351.095204294851, 3353.564036675217, 3364.3775901458066, 3366.5355570326988, 3366.8148251846137, 4762.357081793948, 4763.951930575268, 4765.356676848615, 4775.570198682135, 4776.617870570381, 4128.153728485653, 4277.443932288814, 4327.545607711177, 4329.610335069828, 4335.937695264681, 5039.21892106724, 5040.218766091261, 5042.621803364726, 5044.419891712427, 5045.747712614391, 3652.1052342176336, 3663.377225871608, 3671.9265614687824, 3674.0, 3676.1728611062563, 5145.279660847485, 5294.391145018334, 5316.0, 5329.546988505982, 5364.785408583652, 3694.131879008431, 3718.9628103719156, 3719.1817800083936, 3720.5535335759882, 3741.6819570336825, 3776.188119554309, 3784.6972242220554, 3784.8675296365045, 3786.072412259014, 3788.924221515554, 4330.891727706769, 4334.219840428753, 4337.631301339358, 4339.848105316362, 4343.218220720238, 4921.434035085939, 4996.800127994912, 4998.275250088716, 5074.441811400743, 5086.92369614456, 1260.5273022616518, 1286.9704236610862, 1290.148501988683, 1291.6383412644475, 1291.9612411627666, 828.4863384701524, 873.1530415496958, 886.8137691084816, 903.4985583001497, 908.7182973278304, 4438.090191510732, 4442.089371678798, 4443.866683999485, 4450.0, 4479.619232365286, 5150.356205474316, 5157.896842063138, 5169.922451163236, 5212.244224587414, 5214.7914083436235, 4340.197063543254, 4429.955700443019, 4433.1577000369825, 4458.6878918475395, 4482.574155455227, 2757.2968892932577, 2768.1557125076642, 2768.820026698258, 2775.3200465885584, 2778.930526736807, 4843.418789745253, 4882.316475693406, 4907.576802727241, 4908.975455122773, 4916.459189489154, 5059.721715305694, 5283.762230699628, 5286.15421532553, 5302.549283310885, 5304.549113325334, 4889.755512224375, 4898.608111351084, 4910.312556242057, 4918.5819205367225, 4975.427825800007, 5174.353205849269, 5225.477452254744, 5253.50091741284, 5268.973655131853, 5280.287161233185, 4863.294822250825, 5115.411727651368, 5144.614153938544, 5144.871378215425, 5200.739963001759, 4911.607071434205, 4923.163062279349, 4925.1381008324115, 4925.655204135676, 4931.309616653743, 3740.2145549433835, 3770.547534295902, 3772.6038765929184, 3773.415120656303, 3782.6028267031566, 5048.0156369507595, 5191.377034755854, 5234.424213336454, 5239.895202096013, 5252.947470525399, 5019.7490125494305, 5032.647714659939, 5032.874178145429, 5044.621653376085, 5063.797448102035, 5023.0, 5025.396952365593, 5053.574284343462, 5058.356034288944, 5091.236314552847, 4852.727317542114, 4878.414590249193, 4932.383452068491, 4960.727160006234, 4974.825881094144, 4845.854624361275, 4927.556519913225, 5066.9359434519165, 5073.137566613758, 5101.617378696538, 4977.601791856715, 4980.825671101494, 4993.925091123563, 5000.374953130859, 5001.824936127218], "value": 3829.3782707499895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.3518587889777, 681.6353251010707, 703.2440126863623, 716.799296197065, 718.4396170986629, 12867.613971580857, 13502.459901603948, 13620.795688064687, 13637.318134093293, 13789.241591712453, 13065.869341306585, 13105.410256538455, 13115.6721081973, 13116.803247951288, 13124.212547247173, 624.7844493649684, 756.3533179131846, 760.4524742185617, 773.7291947818275, 774.1523032279645, 769.8768197088467, 769.8806684963812, 769.9114601820806, 770.5838847022601, 771.3983093187322, 833.2001278772356, 835.1940377535677, 835.2482765511028, 835.8370117827026, 835.9874601880977, 670.1991120610872, 784.9332806711465, 803.6785285885634, 808.6159074439653, 813.9796505087361, 592.7421571616361, 592.751044561281, 596.7374355283705, 596.7881402102234, 597.4145337569206, 12492.500299987989, 12493.312867792269, 12524.624261272176, 12526.311052892088, 12535.749285014339, 12084.456199471046, 12166.0, 12458.501659933592, 12662.0, 12692.175008624503, 9753.561089750978, 9897.208223342115, 9974.80050398988, 10123.088921996981, 10593.682189534326, 3916.4516967624554, 3918.5885482024264, 4015.073997354569, 4086.693497987663, 4092.3656833190903, 58647.0, 58823.0, 59179.0, 59772.70113649448, 59802.10296845551, 9534.28492863038, 9724.465154416575, 9731.951340243395, 9913.306068575275, 9923.900760992297, 18645.347412840485, 18916.432507024536, 19092.904535477235, 19117.33089341894, 19125.80053293861, 6640.535162538576, 6762.69567869447, 6768.323167683192, 6785.626790526469, 6856.451483881277, 3623.6376362363553, 3631.654992775682, 3656.2504686539196, 3770.9434358484646, 3799.506064211635, 2648.8013398995154, 2731.18064580625, 2737.6167336572894, 2740.438210166911, 2741.4380052089273, 461.5107985535343, 465.23468893669724, 467.76377929145565, 468.18535747798586, 475.5244755244755, 512.3272515237752, 514.4264145477765, 539.6815878631626, 551.6607286518762, 584.6199970019521, 7016.5088443808445, 7427.18300986891, 7569.356604688553, 7750.651220694969, 8036.156203598655, 491.6018025399438, 492.4131713092532, 495.48469591625025, 542.5442628192337, 543.9782408703608, 3487.215376540309, 3529.27649831789, 3559.94660080099, 3662.066173125836, 3754.0990162360836, 108059.45970270099, 110367.0, 111237.0, 113610.0, 113966.43016784864, 94834.0, 95633.0, 96848.51575742076, 98070.50964745131, 99277.50361248148, 79902.0, 83775.581122094, 85006.57496712476, 87634.12365876387, 90006.0, 7220.819479513054, 7267.563946163247, 7385.556866588022, 7435.851282974419, 7551.660175292015, 50708.239376408645, 51118.48881511137, 51570.35866772009, 51951.740241298554, 52238.47761522488, 70223.0, 72568.27431725615, 73799.0, 75396.0, 75689.62155189189, 8509.87235191485, 8718.82562348762, 8959.910400896168, 9030.090330814079, 9223.953880230825, 9255.537223138681, 9486.857697134687, 9597.040295970348, 9722.611095556098, 10116.949415253172, 8434.915650843413, 8447.704330348408, 8719.564021798758, 8854.778630534289, 9080.545972701206, 8573.657053717781, 8646.82706345882, 9607.279454040836, 9620.278479114235, 10004.499775011365, 8620.91379086201, 8770.12298770118, 8797.692080777142, 8890.155435233642, 8935.240504557185, 7648.655810488653, 7971.681132754625, 8009.0, 8074.341868733216, 8252.917470825216, 7275.599842008529, 7666.808329791576, 7866.646000929857, 7896.6446509906045, 8139.918600814153], "value": 6243.978165562287, "unit": "score"}], "name": "dromaeo_css", "value": 6337.000598580139, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0, 112.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 125.0, 196.0, 125.0, 122.0, 155.0, 121.0, 165.0, 122.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 76.0, 125.0, 75.0, 76.0, 77.0, 76.0, 101.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 116.0, 85.0, 86.0, 85.0, 131.0, 84.0, 85.0, 124.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 64.0, 62.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 79.0, 80.0, 91.0, 81.0, 80.0, 79.0, 79.0, 84.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 128.0, 129.0, 129.0, 127.0, 134.0, 127.0, 172.0, 140.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 166.0, 163.0, 166.0, 163.0, 165.0, 166.0, 166.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 72.0, 66.0, 66.0, 66.0, 67.0, 70.0, 66.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1529.1000000000001, "alertThreshold": 2.0}]} 18:40:05 INFO - Return code: 0 18:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:40:05 INFO - # TBPL SUCCESS # 18:40:05 INFO - Running post-action listener: _resource_record_post_action 18:40:05 INFO - [mozharness: 2016-07-27 01:40:05.371545Z] Finished run-tests step (success) 18:40:05 INFO - Running post-run listener: _resource_record_post_run 18:40:05 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548384768; Read time: 20; Write time: 497696 18:40:05 INFO - TinderboxPrint: CPU usage
13.0% 18:40:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 18:40:05 INFO - TinderboxPrint: I/O write bytes / time
548,384,768 / 497,696 18:40:05 INFO - TinderboxPrint: CPU idle
8,342.1 (87.0%) 18:40:05 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 18:40:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:40:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260034560; Read time: 0; Write time: 269500 18:40:05 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288350208; Read time: 20; Write time: 228196 18:40:06 INFO - Running post-run listener: _upload_blobber_files 18:40:06 INFO - Blob upload gear active. 18:40:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:40:06 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 18:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:07 INFO - (blobuploader) - INFO - Done attempting. 18:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:22 INFO - (blobuploader) - INFO - Done attempting. 18:40:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:40:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:23 INFO - (blobuploader) - INFO - Done attempting. 18:40:23 INFO - (blobuploader) - INFO - Iteration through files over. 18:40:23 INFO - Return code: 0 18:40:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:40:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:40:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec1c6dc45f48a9308fbf6b57ec861bf73e26e24933689c279332c21ac0d891c60124e91261eb5a18fe250f2878c75902a84eb3a18b1ade781a86f96978db04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6183279f2656b6184a88a06fe284d28fd9d69f41ee7fcce3872675b20fb68cf31e777e5cfae25c2e2cbd4201a23807fbe4135db0c1a2a716d3b556301c6e362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee8deeaacd4400e08507ecb9093f7d1742a371891ceacdda0b9e6350ff41e23957b70af27685a815f0dab31644368410ce94413adfaff2ffb0e9c60c9e69a136"} 18:40:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:40:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:40:23 INFO - Contents: 18:40:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ec1c6dc45f48a9308fbf6b57ec861bf73e26e24933689c279332c21ac0d891c60124e91261eb5a18fe250f2878c75902a84eb3a18b1ade781a86f96978db04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6183279f2656b6184a88a06fe284d28fd9d69f41ee7fcce3872675b20fb68cf31e777e5cfae25c2e2cbd4201a23807fbe4135db0c1a2a716d3b556301c6e362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee8deeaacd4400e08507ecb9093f7d1742a371891ceacdda0b9e6350ff41e23957b70af27685a815f0dab31644368410ce94413adfaff2ffb0e9c60c9e69a136"} 18:40:23 INFO - Running post-run listener: copy_logs_to_upload_dir 18:40:23 INFO - Copying logs to upload dir... 18:40:23 INFO - mkdir: /builds/slave/test/build/upload/logs 18:40:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.254069 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-26 18:40:22.921246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 18:40:22.924363) ========= 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=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 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-Non-PGO/sha512/2ec1c6dc45f48a9308fbf6b57ec861bf73e26e24933689c279332c21ac0d891c60124e91261eb5a18fe250f2878c75902a84eb3a18b1ade781a86f96978db04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6183279f2656b6184a88a06fe284d28fd9d69f41ee7fcce3872675b20fb68cf31e777e5cfae25c2e2cbd4201a23807fbe4135db0c1a2a716d3b556301c6e362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee8deeaacd4400e08507ecb9093f7d1742a371891ceacdda0b9e6350ff41e23957b70af27685a815f0dab31644368410ce94413adfaff2ffb0e9c60c9e69a136"} build_url:https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/GbbztbYuSCK8PQ5g-NXX-Q/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-Non-PGO/sha512/2ec1c6dc45f48a9308fbf6b57ec861bf73e26e24933689c279332c21ac0d891c60124e91261eb5a18fe250f2878c75902a84eb3a18b1ade781a86f96978db04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6183279f2656b6184a88a06fe284d28fd9d69f41ee7fcce3872675b20fb68cf31e777e5cfae25c2e2cbd4201a23807fbe4135db0c1a2a716d3b556301c6e362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee8deeaacd4400e08507ecb9093f7d1742a371891ceacdda0b9e6350ff41e23957b70af27685a815f0dab31644368410ce94413adfaff2ffb0e9c60c9e69a136"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 18:40:22.949887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:40:22.950218) ========= 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=cbe409c6de289db6ac707de3000001d4-1469582371.509187-1307097772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:40:23.036191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 18:40:23.036495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 18:40:23.036786) ========= ========= Total master_lag: 0.17 =========