builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1470245668.78 results: success (0) buildid: 20160803101821 builduid: f308108318fd4348b8ee7efe03d9b358 revision: 46cc19e88e94fc8c2525b018e7dab951ffd5673c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:28.783990) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:28.784646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:28.785076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:28.885888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:28.886248) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 10:34:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-08-03 10:34:29 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113206 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:29.014369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:29.014737) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:29.065248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 10:34:29.065672) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 46cc19e88e94fc8c2525b018e7dab951ffd5673c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 46cc19e88e94fc8c2525b018e7dab951ffd5673c --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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 10:34:29,762 truncating revision to first 12 chars 2016-08-03 10:34:29,762 Setting DEBUG logging. 2016-08-03 10:34:29,762 attempt 1/10 2016-08-03 10:34:29,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/46cc19e88e94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 10:34:30,677 unpacking tar archive at: autoland-46cc19e88e94/testing/mozharness/ program finished with exit code 0 elapsedTime=1.250143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 10:34:30.330898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:30.331280) ========= script_repo_revision: 46cc19e88e94fc8c2525b018e7dab951ffd5673c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:30.331737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:30.332035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 10:34:30.343106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 10:34:30.343455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:34:31 INFO - MultiFileLogger online at 20160803 10:34:31 in /builds/slave/test 10:34:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:34:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:31 INFO - {'append_to_log': False, 10:34:31 INFO - 'base_work_dir': '/builds/slave/test', 10:34:31 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:34:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:31 INFO - 'branch': 'Autoland-Non-PGO', 10:34:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:31 INFO - 'config_files': ('talos/linux_config.py',), 10:34:31 INFO - 'default_actions': ('clobber', 10:34:31 INFO - 'read-buildbot-config', 10:34:31 INFO - 'download-and-extract', 10:34:31 INFO - 'populate-webroot', 10:34:31 INFO - 'create-virtualenv', 10:34:31 INFO - 'install', 10:34:31 INFO - 'run-tests'), 10:34:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:31 INFO - 'download_minidump_stackwalk': True, 10:34:31 INFO - 'download_symbols': 'ondemand', 10:34:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:31 INFO - 'installer_path': 'installer.exe', 10:34:31 INFO - 'log_level': 'info', 10:34:31 INFO - 'log_name': 'talos', 10:34:31 INFO - 'log_to_console': True, 10:34:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:34:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:34:31 INFO - 'opt_config_files': (), 10:34:31 INFO - 'pip_index': False, 10:34:31 INFO - 'sps_profile': False, 10:34:31 INFO - 'sps_profile_interval': 0, 10:34:31 INFO - 'suite': 'dromaeojs', 10:34:31 INFO - 'system_bits': '32', 10:34:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:31 INFO - 'title': 'talos-linux64-ix-068', 10:34:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:31 INFO - 'use_talos_json': True, 10:34:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:31 INFO - 'work_dir': 'build'} 10:34:31 INFO - [mozharness: 2016-08-03 17:34:31.133937Z] Running clobber step. 10:34:31 INFO - Running pre-action listener: _resource_record_pre_action 10:34:31 INFO - Running main action method: clobber 10:34:31 INFO - rmtree: /builds/slave/test/build 10:34:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:31 INFO - Running post-action listener: _resource_record_post_action 10:34:31 INFO - [mozharness: 2016-08-03 17:34:31.612798Z] Finished clobber step (success) 10:34:31 INFO - [mozharness: 2016-08-03 17:34:31.612901Z] Running read-buildbot-config step. 10:34:31 INFO - Running pre-action listener: _resource_record_pre_action 10:34:31 INFO - Running main action method: read_buildbot_config 10:34:31 INFO - Using buildbot properties: 10:34:31 INFO - { 10:34:31 INFO - "project": "", 10:34:31 INFO - "product": "firefox", 10:34:31 INFO - "script_repo_revision": "production", 10:34:31 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:34:31 INFO - "repository": "", 10:34:31 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:34:31 INFO - "buildid": "20160803101821", 10:34:31 INFO - "pgo_build": "False", 10:34:31 INFO - "basedir": "/builds/slave/test", 10:34:31 INFO - "buildnumber": 140, 10:34:31 INFO - "slavename": "talos-linux64-ix-068", 10:34:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:34:31 INFO - "platform": "ubuntu64_hw", 10:34:31 INFO - "scheduler": "tests-autoland-linux64-talos", 10:34:31 INFO - "branch": "autoland", 10:34:31 INFO - "repo_path": "integration/autoland", 10:34:31 INFO - "revision": "46cc19e88e94fc8c2525b018e7dab951ffd5673c", 10:34:31 INFO - "stage_platform": "linux64", 10:34:31 INFO - "builduid": "f308108318fd4348b8ee7efe03d9b358", 10:34:31 INFO - "slavebuilddir": "test" 10:34:31 INFO - } 10:34:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:34:31 INFO - Running post-action listener: _resource_record_post_action 10:34:31 INFO - [mozharness: 2016-08-03 17:34:31.615614Z] Finished read-buildbot-config step (success) 10:34:31 INFO - [mozharness: 2016-08-03 17:34:31.615704Z] Running download-and-extract step. 10:34:31 INFO - Running pre-action listener: _resource_record_pre_action 10:34:31 INFO - Running main action method: download_and_extract 10:34:31 INFO - mkdir: /builds/slave/test/build/tests 10:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:31 INFO - https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:34:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:34:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:34:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:34:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:34:32 INFO - Downloaded 1361 bytes. 10:34:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:34:32 INFO - Using the following test package requirements: 10:34:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:34:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:34:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:34:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'jsshell-linux-x86_64.zip'], 10:34:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:34:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:34:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:34:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:34:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:34:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:34:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:32 INFO - https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:33 INFO - Downloaded 20241543 bytes. 10:34:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:34:34 INFO - Return code: 0 10:34:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:34: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')]} 10:34:34 INFO - https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:34:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:35 INFO - Downloaded 20241543 bytes. 10:34:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:34:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:34:36 INFO - Return code: 0 10:34: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')]} 10:34:36 INFO - https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:34:37 INFO - Downloaded 14413723 bytes. 10:34:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:34:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:34:37 INFO - Return code: 0 10:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:37 INFO - https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:34:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:34:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:34:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:34:39 INFO - Downloaded 55580554 bytes. 10:34:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:34:39 INFO - mkdir: /builds/slave/test/properties 10:34:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:39 INFO - Contents: 10:34:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:34:39 INFO - Running post-action listener: _resource_record_post_action 10:34:39 INFO - Running post-action listener: set_extra_try_arguments 10:34:39 INFO - [mozharness: 2016-08-03 17:34:39.678456Z] Finished download-and-extract step (success) 10:34:39 INFO - [mozharness: 2016-08-03 17:34:39.678688Z] Running populate-webroot step. 10:34:39 INFO - Running pre-action listener: _resource_record_pre_action 10:34:39 INFO - Running main action method: populate_webroot 10:34:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:39 INFO - '--tppagecycles', 10:34:39 INFO - '7'], 10:34:39 INFO - 'tests': ['tsvgm']}}, 10:34:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['damp', 'tps']}, 10:34:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'tests': ['damp', 'tps']}, 10:34:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['dromaeo_dom']}, 10:34:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['basic_compositor_video']}, 10:34:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:34:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['a11yr', 10:34:39 INFO - 'ts_paint', 10:34:39 INFO - 'tpaint', 10:34:39 INFO - 'sessionrestore', 10:34:39 INFO - 'sessionrestore_no_auto_restore', 10:34:39 INFO - 'tabpaint']}, 10:34:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['tsvgx', 10:34:39 INFO - 'tsvgr_opacity', 10:34:39 INFO - 'tart', 10:34:39 INFO - 'tscrollx', 10:34:39 INFO - 'cart']}, 10:34:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:39 INFO - 'tsvgr_opacity', 10:34:39 INFO - 'tart', 10:34:39 INFO - 'tscrollx', 10:34:39 INFO - 'cart']}, 10:34:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'talos_options': ['--disable-e10s'], 10:34:39 INFO - 'tests': ['tp5o']}, 10:34:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'tests': ['tp5o']}, 10:34:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'talos_options': ['--disable-e10s', 10:34:39 INFO - '--xperf_path', 10:34:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:39 INFO - 'tests': ['tp5n']}, 10:34:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:39 INFO - 'talos_options': ['--xperf_path', 10:34:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:39 INFO - 'tests': ['tp5n']}}, 10:34:39 INFO - 'talos.zip': {'path': '', 10:34:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:39 INFO - Running post-action listener: _resource_record_post_action 10:34:39 INFO - [mozharness: 2016-08-03 17:34:39.698628Z] Finished populate-webroot step (success) 10:34:39 INFO - [mozharness: 2016-08-03 17:34:39.698717Z] Running create-virtualenv step. 10:34:39 INFO - Running pre-action listener: _resource_record_pre_action 10:34:39 INFO - Running main action method: create_virtualenv 10:34:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:34:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:39 INFO - Using real prefix '/usr' 10:34:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:42 INFO - Installing pip.................done. 10:34:42 INFO - Return code: 0 10:34:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:34:42 INFO - Using env: {'DISPLAY': ':0', 10:34:42 INFO - 'HOME': '/home/cltbld', 10:34:42 INFO - 'LANG': 'en_US.UTF-8', 10:34:42 INFO - 'LANGUAGE': 'en_US:en', 10:34:42 INFO - 'LOGNAME': 'cltbld', 10:34:42 INFO - 'MAIL': '/var/mail/cltbld', 10:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:42 INFO - 'MOZ_NO_REMOTE': '1', 10:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:42 INFO - 'NO_EM_RESTART': '1', 10:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:42 INFO - 'PWD': '/builds/slave/test', 10:34:42 INFO - 'SHELL': '/bin/bash', 10:34:42 INFO - 'SHLVL': '1', 10:34:42 INFO - 'TERM': 'linux', 10:34:42 INFO - 'TMOUT': '86400', 10:34:42 INFO - 'USER': 'cltbld', 10:34:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:42 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:34:42 INFO - Cleaning up... 10:34:42 INFO - Return code: 0 10:34:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:34:42 INFO - Using env: {'DISPLAY': ':0', 10:34:42 INFO - 'HOME': '/home/cltbld', 10:34:42 INFO - 'LANG': 'en_US.UTF-8', 10:34:42 INFO - 'LANGUAGE': 'en_US:en', 10:34:42 INFO - 'LOGNAME': 'cltbld', 10:34:42 INFO - 'MAIL': '/var/mail/cltbld', 10:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:42 INFO - 'MOZ_NO_REMOTE': '1', 10:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:42 INFO - 'NO_EM_RESTART': '1', 10:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:42 INFO - 'PWD': '/builds/slave/test', 10:34:42 INFO - 'SHELL': '/bin/bash', 10:34:42 INFO - 'SHLVL': '1', 10:34:42 INFO - 'TERM': 'linux', 10:34:42 INFO - 'TMOUT': '86400', 10:34:42 INFO - 'USER': 'cltbld', 10:34:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:42 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:42 INFO - Downloading/unpacking psutil>=3.1.1 10:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:44 INFO - Installing collected packages: psutil 10:34:44 INFO - Running setup.py install for psutil 10:34:44 INFO - building 'psutil._psutil_linux' extension 10:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:34:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:34:45 INFO - building 'psutil._psutil_posix' extension 10:34:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:34:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:34:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:45 INFO - Successfully installed psutil 10:34:45 INFO - Cleaning up... 10:34:45 INFO - Return code: 0 10:34:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:45 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:34:45 INFO - Using env: {'DISPLAY': ':0', 10:34:45 INFO - 'HOME': '/home/cltbld', 10:34:45 INFO - 'LANG': 'en_US.UTF-8', 10:34:45 INFO - 'LANGUAGE': 'en_US:en', 10:34:45 INFO - 'LOGNAME': 'cltbld', 10:34:45 INFO - 'MAIL': '/var/mail/cltbld', 10:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:45 INFO - 'MOZ_NO_REMOTE': '1', 10:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:45 INFO - 'NO_EM_RESTART': '1', 10:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:45 INFO - 'PWD': '/builds/slave/test', 10:34:45 INFO - 'SHELL': '/bin/bash', 10:34:45 INFO - 'SHLVL': '1', 10:34:45 INFO - 'TERM': 'linux', 10:34:45 INFO - 'TMOUT': '86400', 10:34:45 INFO - 'USER': 'cltbld', 10:34:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:45 INFO - '_': '/tools/buildbot/bin/python'} 10:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:47 INFO - Installing collected packages: mozsystemmonitor 10:34:47 INFO - Running setup.py install for mozsystemmonitor 10:34:47 INFO - Successfully installed mozsystemmonitor 10:34:47 INFO - Cleaning up... 10:34:47 INFO - Return code: 0 10:34:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34: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')]} 10:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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')]} 10:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:34:47 INFO - Using env: {'DISPLAY': ':0', 10:34:47 INFO - 'HOME': '/home/cltbld', 10:34:47 INFO - 'LANG': 'en_US.UTF-8', 10:34:47 INFO - 'LANGUAGE': 'en_US:en', 10:34:47 INFO - 'LOGNAME': 'cltbld', 10:34:47 INFO - 'MAIL': '/var/mail/cltbld', 10:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:47 INFO - 'MOZ_NO_REMOTE': '1', 10:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:47 INFO - 'NO_EM_RESTART': '1', 10:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:47 INFO - 'PWD': '/builds/slave/test', 10:34:47 INFO - 'SHELL': '/bin/bash', 10:34:47 INFO - 'SHLVL': '1', 10:34:47 INFO - 'TERM': 'linux', 10:34:47 INFO - 'TMOUT': '86400', 10:34:47 INFO - 'USER': 'cltbld', 10:34:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:47 INFO - '_': '/tools/buildbot/bin/python'} 10:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:50 INFO - warning: no files found matching '*.txt' 10:34:50 INFO - no previously-included directories found matching 'build' 10:34:50 INFO - no previously-included directories found matching 'dist' 10:34:50 INFO - no previously-included directories found matching '.git*' 10:34:50 INFO - Installing collected packages: jsonschema, functools32 10:34:50 INFO - Running setup.py install for functools32 10:34:50 INFO - warning: no files found matching '*.txt' 10:34:50 INFO - no previously-included directories found matching 'build' 10:34:50 INFO - no previously-included directories found matching 'dist' 10:34:50 INFO - no previously-included directories found matching '.git*' 10:34:50 INFO - Successfully installed jsonschema functools32 10:34:50 INFO - Cleaning up... 10:34:50 INFO - Return code: 0 10:34:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:34:50 INFO - Using env: {'DISPLAY': ':0', 10:34:50 INFO - 'HOME': '/home/cltbld', 10:34:50 INFO - 'LANG': 'en_US.UTF-8', 10:34:50 INFO - 'LANGUAGE': 'en_US:en', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MAIL': '/var/mail/cltbld', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SHLVL': '1', 10:34:50 INFO - 'TERM': 'linux', 10:34:50 INFO - 'TMOUT': '86400', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - '_': '/tools/buildbot/bin/python'} 10:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:34:50 INFO - Cleaning up... 10:34:50 INFO - Return code: 0 10:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:34:50 INFO - Using env: {'DISPLAY': ':0', 10:34:50 INFO - 'HOME': '/home/cltbld', 10:34:50 INFO - 'LANG': 'en_US.UTF-8', 10:34:50 INFO - 'LANGUAGE': 'en_US:en', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MAIL': '/var/mail/cltbld', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SHLVL': '1', 10:34:50 INFO - 'TERM': 'linux', 10:34:50 INFO - 'TMOUT': '86400', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - '_': '/tools/buildbot/bin/python'} 10:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34: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 10:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:53 INFO - Downloading docopt-0.6.1.tar.gz 10:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:53 INFO - Running setup.py install for blobuploader 10:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:53 INFO - Running setup.py install for requests 10:34:53 INFO - Running setup.py install for docopt 10:34:53 INFO - Successfully installed blobuploader requests docopt 10:34:53 INFO - Cleaning up... 10:34:53 INFO - Return code: 0 10:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:53 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:34:53 INFO - Using env: {'DISPLAY': ':0', 10:34:53 INFO - 'HOME': '/home/cltbld', 10:34:53 INFO - 'LANG': 'en_US.UTF-8', 10:34:53 INFO - 'LANGUAGE': 'en_US:en', 10:34:53 INFO - 'LOGNAME': 'cltbld', 10:34:53 INFO - 'MAIL': '/var/mail/cltbld', 10:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:53 INFO - 'MOZ_NO_REMOTE': '1', 10:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:53 INFO - 'NO_EM_RESTART': '1', 10:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:53 INFO - 'PWD': '/builds/slave/test', 10:34:53 INFO - 'SHELL': '/bin/bash', 10:34:53 INFO - 'SHLVL': '1', 10:34:53 INFO - 'TERM': 'linux', 10:34:53 INFO - 'TMOUT': '86400', 10:34:53 INFO - 'USER': 'cltbld', 10:34:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:53 INFO - '_': '/tools/buildbot/bin/python'} 10:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:54 INFO - Running setup.py (path:/tmp/pip-tkHGd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:54 INFO - Running setup.py (path:/tmp/pip-uFHaz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:54 INFO - Running setup.py (path:/tmp/pip-GcUnN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:54 INFO - Running setup.py (path:/tmp/pip-P21jgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:54 INFO - Running setup.py (path:/tmp/pip-yMzt4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:54 INFO - Running setup.py (path:/tmp/pip-vcZN6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:54 INFO - Running setup.py (path:/tmp/pip-LteuMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:54 INFO - Running setup.py (path:/tmp/pip-yJfU4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:54 INFO - Running setup.py (path:/tmp/pip-KNhL3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:54 INFO - Running setup.py (path:/tmp/pip-f2pvjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:54 INFO - Running setup.py (path:/tmp/pip-UkXumj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:54 INFO - Running setup.py (path:/tmp/pip-lbc8Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:55 INFO - Running setup.py (path:/tmp/pip-pgceur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:55 INFO - Running setup.py (path:/tmp/pip-HkR9nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:55 INFO - Running setup.py (path:/tmp/pip-oJ96Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:55 INFO - Running setup.py (path:/tmp/pip-ipHu7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:55 INFO - Running setup.py (path:/tmp/pip-TNHUED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:55 INFO - Running setup.py install for manifestparser 10:34:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:55 INFO - Running setup.py install for mozcrash 10:34:55 INFO - Running setup.py install for mozdebug 10:34:55 INFO - Running setup.py install for mozdevice 10:34:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:34:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:55 INFO - Running setup.py install for mozfile 10:34:55 INFO - Running setup.py install for mozhttpd 10:34:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:55 INFO - Running setup.py install for mozinfo 10:34:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for mozInstall 10:34:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for mozleak 10:34:56 INFO - Running setup.py install for mozlog 10:34:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for moznetwork 10:34:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for mozprocess 10:34:56 INFO - Running setup.py install for mozprofile 10:34:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for mozrunner 10:34:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:56 INFO - Running setup.py install for mozscreenshot 10:34:56 INFO - Running setup.py install for moztest 10:34:57 INFO - Running setup.py install for mozversion 10:34:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:57 INFO - Cleaning up... 10:34:57 INFO - Return code: 0 10:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:57 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:34:57 INFO - Using env: {'DISPLAY': ':0', 10:34:57 INFO - 'HOME': '/home/cltbld', 10:34:57 INFO - 'LANG': 'en_US.UTF-8', 10:34:57 INFO - 'LANGUAGE': 'en_US:en', 10:34:57 INFO - 'LOGNAME': 'cltbld', 10:34:57 INFO - 'MAIL': '/var/mail/cltbld', 10:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:57 INFO - 'MOZ_NO_REMOTE': '1', 10:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:57 INFO - 'NO_EM_RESTART': '1', 10:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:57 INFO - 'PWD': '/builds/slave/test', 10:34:57 INFO - 'SHELL': '/bin/bash', 10:34:57 INFO - 'SHLVL': '1', 10:34:57 INFO - 'TERM': 'linux', 10:34:57 INFO - 'TMOUT': '86400', 10:34:57 INFO - 'USER': 'cltbld', 10:34:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:57 INFO - '_': '/tools/buildbot/bin/python'} 10:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:57 INFO - Running setup.py (path:/tmp/pip-XMclEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:57 INFO - Running setup.py (path:/tmp/pip-O7IZzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:57 INFO - Running setup.py (path:/tmp/pip-LgMuRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:57 INFO - Running setup.py (path:/tmp/pip-oqe6Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:57 INFO - Running setup.py (path:/tmp/pip-wg72xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:57 INFO - Running setup.py (path:/tmp/pip-t0OheZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:57 INFO - Running setup.py (path:/tmp/pip-yYvlGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:57 INFO - Running setup.py (path:/tmp/pip-zoVPcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:57 INFO - Running setup.py (path:/tmp/pip-Lw2Pz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:58 INFO - Running setup.py (path:/tmp/pip-FCp0RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:58 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)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:58 INFO - Running setup.py (path:/tmp/pip-8mlIHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:58 INFO - Running setup.py (path:/tmp/pip-C1O8A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:58 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)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:58 INFO - Running setup.py (path:/tmp/pip-mIsROU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:58 INFO - Running setup.py (path:/tmp/pip-w38bzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:58 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)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:58 INFO - Running setup.py (path:/tmp/pip-lWflLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:58 INFO - Running setup.py (path:/tmp/pip-tnq26Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:58 INFO - Running setup.py (path:/tmp/pip-riSTIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:34:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:00 INFO - Downloading blessings-1.6.tar.gz 10:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:00 INFO - Installing collected packages: blessings 10:35:00 INFO - Running setup.py install for blessings 10:35:00 INFO - Successfully installed blessings 10:35:00 INFO - Cleaning up... 10:35:00 INFO - Return code: 0 10:35:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:00 INFO - Reading from file tmpfile_stdout 10:35:00 INFO - Current package versions: 10:35:00 INFO - argparse == 1.2.1 10:35:00 INFO - blessings == 1.6 10:35:00 INFO - blobuploader == 1.2.4 10:35:00 INFO - docopt == 0.6.1 10:35:00 INFO - functools32 == 3.2.3-2 10:35:00 INFO - jsonschema == 2.5.1 10:35:00 INFO - manifestparser == 1.1 10:35:00 INFO - mozInstall == 1.12 10:35:00 INFO - mozcrash == 0.17 10:35:00 INFO - mozdebug == 0.1 10:35:00 INFO - mozdevice == 0.48 10:35:00 INFO - mozfile == 1.2 10:35:00 INFO - mozhttpd == 0.7 10:35:00 INFO - mozinfo == 0.9 10:35:00 INFO - mozleak == 0.1 10:35:00 INFO - mozlog == 3.3 10:35:00 INFO - moznetwork == 0.27 10:35:00 INFO - mozprocess == 0.23 10:35:00 INFO - mozprofile == 0.28 10:35:00 INFO - mozrunner == 6.12 10:35:00 INFO - mozscreenshot == 0.1 10:35:00 INFO - mozsystemmonitor == 0.3 10:35:00 INFO - moztest == 0.7 10:35:00 INFO - mozversion == 1.4 10:35:00 INFO - psutil == 3.1.1 10:35:00 INFO - requests == 1.2.3 10:35:00 INFO - wsgiref == 0.1.2 10:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:00 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 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:35:00 INFO - Using env: {'DISPLAY': ':0', 10:35:00 INFO - 'HOME': '/home/cltbld', 10:35:00 INFO - 'LANG': 'en_US.UTF-8', 10:35:00 INFO - 'LANGUAGE': 'en_US:en', 10:35:00 INFO - 'LOGNAME': 'cltbld', 10:35:00 INFO - 'MAIL': '/var/mail/cltbld', 10:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:00 INFO - 'MOZ_NO_REMOTE': '1', 10:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:01 INFO - 'NO_EM_RESTART': '1', 10:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:01 INFO - 'PWD': '/builds/slave/test', 10:35:01 INFO - 'SHELL': '/bin/bash', 10:35:01 INFO - 'SHLVL': '1', 10:35:01 INFO - 'TERM': 'linux', 10:35:01 INFO - 'TMOUT': '86400', 10:35:01 INFO - 'USER': 'cltbld', 10:35:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:01 INFO - '_': '/tools/buildbot/bin/python'} 10:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:35:01 INFO - Cleaning up... 10:35:01 INFO - Return code: 0 10:35:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:35:01 INFO - Using env: {'DISPLAY': ':0', 10:35:01 INFO - 'HOME': '/home/cltbld', 10:35:01 INFO - 'LANG': 'en_US.UTF-8', 10:35:01 INFO - 'LANGUAGE': 'en_US:en', 10:35:01 INFO - 'LOGNAME': 'cltbld', 10:35:01 INFO - 'MAIL': '/var/mail/cltbld', 10:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:01 INFO - 'MOZ_NO_REMOTE': '1', 10:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:01 INFO - 'NO_EM_RESTART': '1', 10:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:01 INFO - 'PWD': '/builds/slave/test', 10:35:01 INFO - 'SHELL': '/bin/bash', 10:35:01 INFO - 'SHLVL': '1', 10:35:01 INFO - 'TERM': 'linux', 10:35:01 INFO - 'TMOUT': '86400', 10:35:01 INFO - 'USER': 'cltbld', 10:35:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:01 INFO - '_': '/tools/buildbot/bin/python'} 10:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:01 INFO - Cleaning up... 10:35:01 INFO - Return code: 0 10:35:01 INFO - Running post-action listener: _resource_record_post_action 10:35:01 INFO - Running post-action listener: _start_resource_monitoring 10:35:01 INFO - Starting resource monitoring. 10:35:01 INFO - [mozharness: 2016-08-03 17:35:01.471787Z] Finished create-virtualenv step (success) 10:35:01 INFO - [mozharness: 2016-08-03 17:35:01.472224Z] Running install step. 10:35:01 INFO - Running pre-action listener: _resource_record_pre_action 10:35:01 INFO - Running main action method: install 10:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:01 INFO - Reading from file tmpfile_stdout 10:35:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:01 INFO - Reading from file tmpfile_stdout 10:35:01 INFO - Output received: 10:35:01 INFO - Usage: mozinstall [options] installer 10:35:01 INFO - Options: 10:35:01 INFO - -h, --help show this help message and exit 10:35:01 INFO - -d DEST, --destination=DEST 10:35:01 INFO - Directory to install application into. [default: 10:35:01 INFO - "/builds/slave/test"] 10:35:01 INFO - --app=APP Application being installed. [default: firefox] 10:35:01 INFO - mkdir: /builds/slave/test/build/application 10:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:35:17 INFO - Reading from file tmpfile_stdout 10:35:17 INFO - Output received: 10:35:17 INFO - /builds/slave/test/build/application/firefox/firefox 10:35:17 INFO - Running post-action listener: _resource_record_post_action 10:35:17 INFO - [mozharness: 2016-08-03 17:35:17.883058Z] Finished install step (success) 10:35:17 INFO - [mozharness: 2016-08-03 17:35:17.883479Z] Running run-tests step. 10:35:17 INFO - Running pre-action listener: _resource_record_pre_action 10:35:17 INFO - Running main action method: run_tests 10:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:35:17 INFO - Python 2.7.3 10:35:17 INFO - Return code: 0 10:35:17 INFO - grabbing minidump binary from tooltool 10:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:17 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 0x217c3b0>, '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 0x217d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:35:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:35:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:35:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:35:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:35:17 INFO - Return code: 0 10:35:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:35:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:35:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:35:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:35:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 10:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 10:35:17 INFO - Using env: {'DISPLAY': ':0', 10:35:17 INFO - 'HOME': '/home/cltbld', 10:35:17 INFO - 'LANG': 'en_US.UTF-8', 10:35:17 INFO - 'LANGUAGE': 'en_US:en', 10:35:17 INFO - 'LOGNAME': 'cltbld', 10:35:17 INFO - 'MAIL': '/var/mail/cltbld', 10:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:17 INFO - 'MOZ_NO_REMOTE': '1', 10:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:17 INFO - 'NO_EM_RESTART': '1', 10:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:17 INFO - 'PWD': '/builds/slave/test', 10:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:35:17 INFO - 'SHELL': '/bin/bash', 10:35:17 INFO - 'SHLVL': '1', 10:35:17 INFO - 'TERM': 'linux', 10:35:17 INFO - 'TMOUT': '86400', 10:35:17 INFO - 'USER': 'cltbld', 10:35:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682', 10:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:17 INFO - '_': '/tools/buildbot/bin/python'} 10:35:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 10:35:18 INFO - mozversion application_buildid: 20160803101821 10:35:18 INFO - mozversion application_changeset: 46cc19e88e94fc8c2525b018e7dab951ffd5673c 10:35:18 INFO - mozversion application_display_name: Nightly 10:35:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:35:18 INFO - mozversion application_name: Firefox 10:35:18 INFO - mozversion application_remotingname: firefox 10:35:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:35:18 INFO - mozversion application_vendor: Mozilla 10:35:18 INFO - mozversion application_version: 51.0a1 10:35:18 INFO - mozversion platform_buildid: 20160803101821 10:35:18 INFO - mozversion platform_changeset: 46cc19e88e94fc8c2525b018e7dab951ffd5673c 10:35:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:35:18 INFO - mozversion platform_version: 51.0a1 10:35:18 INFO - using testdate: 1470245718 10:35:18 INFO - actual date: 1470245718 10:35:18 INFO - starting webserver on 'localhost:36484' 10:35:18 INFO - SUITE-START | Running 2 tests 10:35:18 INFO - TEST-START | dromaeo_css 10:35:18 INFO - operating with platform_type : linux_ 10:35:18 INFO - Initialising browser for dromaeo_css test... 10:35:18 INFO - TEST-INFO | started process 25384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xLXBk/profile http://localhost:36484/getInfo.html) 10:35:22 INFO - PROCESS | 25384 | __metrics Screen width/height:1600/1200 10:35:22 INFO - PROCESS | 25384 | colorDepth:24 10:35:22 INFO - PROCESS | 25384 | Browser inner width/height: 1024/697 10:35:22 INFO - PROCESS | 25384 | __metrics 10:35:23 INFO - PROCESS | 25384 | 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" 10:35:23 INFO - PROCESS | 25384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:24 INFO - TEST-INFO | 25384: exit 0 10:35:24 INFO - Browser initialized. 10:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:24 INFO - TEST-INFO | started process 25468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xLXBk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:36 INFO - PROCESS | 25468 | RSS: Main: 157818880 10:35:36 INFO - PROCESS | 25468 | 10:36:27 INFO - PROCESS | 25468 | 1470245787591 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:38:41 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36484/tests/dromaeo/cssquery-ext.html) 10:38:43 INFO - PROCESS | 25468 | RSS: Main: 256253952 10:38:43 INFO - PROCESS | 25468 | 10:41:45 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-ext.html (next: http://localhost:36484/tests/dromaeo/cssquery-jquery.html) 10:41:46 INFO - PROCESS | 25468 | RSS: Main: 249634816 10:41:46 INFO - PROCESS | 25468 | 10:44:48 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36484/tests/dromaeo/cssquery-mootools.html) 10:44:49 INFO - PROCESS | 25468 | RSS: Main: 187604992 10:44:49 INFO - PROCESS | 25468 | 10:47:51 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36484/tests/dromaeo/cssquery-prototype.html) 10:47:51 INFO - PROCESS | 25468 | RSS: Main: 189755392 10:47:51 INFO - PROCESS | 25468 | 10:50:55 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36484/tests/dromaeo/cssquery-yui.html) 10:50:55 INFO - PROCESS | 25468 | RSS: Main: 191418368 10:50:55 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | Cycle 1(1): loaded http://localhost:36484/tests/dromaeo/cssquery-yui.html (next: http://localhost:36484/tests/dromaeo/cssquery-dojo.html) 10:53:58 INFO - PROCESS | 25468 | RSS: Main: 283877376 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | __start_tp_report 10:53:58 INFO - PROCESS | 25468 | _x_x_mozilla_page_load 10:53:58 INFO - PROCESS | 25468 | _x_x_mozilla_page_load_details 10:53:58 INFO - PROCESS | 25468 | |i|pagename|runs| 10:53:58 INFO - PROCESS | 25468 | |0;dojo.html;2678.62499250105;2695.6091366751807;2703.4863375958566;2721.3332733480293;2725.100716763467;4639.559241872017;4707.388039554853;4798.520147985199;4873.902521949559;4881.804727810888;4768.475467698559;4805.567498925096;4816.783244753986;4826.638002149835;4909.459959404463;4417.138657961698;4454.175977444167;4487.349334346518;4508.458984921814;4598.97700511497;4529.116822219668;4544.613707834838;4559.407277053979;4559.475660299058;4567.08658268346;4293.076988447468;4341.826326946918;4344.391785150082;4478.708883922567;4510.0979804039325;4375.540568240321;4396.472423309224;4402.603765661074;4404;4419.734815911055;4409.933850992237;4432.246518091933;4433.490148632916;4433.689641725081;4438.090191510732;4788.209945359012;4795.2807078938085;4795.736234507101;4851.660383773137;4910.803567857317;5126.61550383719;5211.062008838408;5227.869303267411;5293.470652934676;5299.5760339172775;5327.147656375;5329.706866122362;5331.866703332409;5332.253484512172;5336.573074154058;4692.694974826625;4752.239641657318;4800.903981920342;4808.447028591757;4871.585915197177;5298.258243845865;5334.839954801362;5345.866353341197;5363.115086010843;5366.597505187126;5084.694918304914;5091.719955402488;5126.871828204325;5134.229865520202;5136.5377116059735;4831.347768051339;5124.385073791094;5139.408967968731;5141.25451809493;5217.530422262014;5093.923591146136;5106.744662766847;5115.87210319745;5122.692638441631;5124.948750512447;5101.489851014869;5104.004719079818;5104.132297509433;5104.923426148611;5136.794528218904;4059.06641472463;4080.2451546464;4086.5300490443383;4138.979305103455;4236.618704316565;3792.355299599075;3799;3847.2305538891774;3861.1119442527815;3874.3994680824517;4439.267520859086;4452.688311818141;4458.8439404620685;4495.730256184639;4511.932321015187;4927.063857867065;5091.974540127276;5243.711595862188;5249.711265880337;5251.711155886463;4385.912281754347;4436.844710435119;4446.155230506193;4480.731156130642;4485.708428952108;4650.069986002813;4650.581447669726;4650.906981860344;4691.859244222679;4696.436427628706;4726.503717109791;4846.394200724839;4847.975760121318;4892.951070489392;4898.53463920927;5177.741112944263;5194.194899790538;5202.037623039599;5247.370315562004;5253.763580638957;4834.540718631724;4840.636952228527;4866.075445665312;4922.556969872729;4922.901541969069;4871.683340582851;5025.47232540578;5116.027954688598;5123.923141152811;5142.614303927146;5124.718140502159;5176.456472070529;5188.118019936695;5212.426633070435;5220.843374698765;5008.749562521933;5010.749462526786;5019.548240658358;5022.67352622093;5066.164082926276;4765.285207218945;4945.258211268195;5004.39947206323;5017.046761115376;5017.874553136201;4898.53463920927;4988;4997.100521906092;4997.750112494434;5003.199488081889;5035.949640503694;5046.949530504648;5048.747562621781;5049.368828896388;5097.92353114711;4798.880027999328;4846.079244943449;4848.296996935495;4938.604911606991;4950.084234416644 10:53:58 INFO - PROCESS | 25468 | |1;ext.html;556.9749361278742;564.8644325361914;568.6190252530804;575.5136909311632;575.9827205183843;28383.858080709593;38654.806725966366;40101.59898401012;40163.79918100413;44520;40076.59923400765;40387;40398;40515;40785.18429631413;7282.380997615209;7650;7775.650095745705;7800.804979875492;7801.141874393812;9696.903030969706;9983.301168918179;9995.750106247366;10393.84409233862;10398.636047738331;10074.597016119347;10176.694699159038;10184.185265178805;10184.847227291559;10185.89814101857;9951.253655975795;9997.600095996151;10017.298789084767;10018.599256029715;10024.749381265454;9715.27135464843;9772.560234789451;9776.657816976443;9786.363886347364;9786.608535658565;37858;38015.809920950494;38040.80979595112;38067.23865522702;38083.61916380828;3064.264576501646;3182.8567714452674;3350.3299340131825;3650.105724097613;3723.6090210527777;29752.8512357439;29849.552256716168;30179;30559;30672.846635766902;3238.3199528098894;3317.56871606692;3326.3181047885128;3388.2376465295356;3466.185446420089;242630;243261;243484;243585;244276;31940.36119277648;32944.83527582395;32962.8351858244;53182;53538.732306339;34159.65840341614;34239.31521369558;34324.31351372958;34380.14049648779;34384.484232736526;13224.404901779442;13430.328483575782;13480.460781568823;13489.527866524624;13491.730165396637;9993.80012399748;10647.25469217163;10769.730756731144;10947.34315941046;10999.725006874733;8017.6792928283385;8021.117677055519;8051.51690898548;8115.715949941724;8120.796980075427;3069.478188707925;3089.258577941278;3094.8607312670533;3135.5766971459016;3160.762942779301;899.6851102114208;905.2893478619252;927.9931274567035;963.8843338799248;1029.897010298964;27455.45089098247;29287.560686589717;29305.56041659377;29376.773222041073;29757.107286781433;950.7290422229631;961.0965692249403;961.9951900240594;1007.3603261928728;1031.2368847053126;15069.849301507064;15174.24128793556;15430.38278468871;15664.530064098095;15714.449994250146;402010;405892;406232;406585;406661;48978.26532602014;49462;49549;49565.50434495681;49605.751971239915;1067.556963860005;1181.078758568318;1184.2065815903366;1197.3474456421097;1206.9155159138952;28033.43933121367;29129.7087029127;29277.85361073181;29370.265743356587;29955.550666739582;43014.56985430106;43557.564424355354;43560.564394356916;43724;43732.78133609312;314305;318009;318170;318284;318488;25337.493250135263;25932.740672593787;25941.22176334713;27018.459630807665;27133.74395072525;42291.57708422876;42436.78781606072;42450.150996980505;42540.36189457099;42627.7868610655;35528.822355888056;36029.27941441209;36222.4566631506;36654.26691466209;36659.45010824787;35796.64203357933;36377.636223637426;36384.818075909454;36553.268934621694;36769.63230367662;35521.82239088788;35730.28539429249;35744;36850.07874803151;39207.80396098115;32251.35497290088;34016.65983340234;34443.655563444045;34476.482852757734;34476.655233447345;24901.750982489943;24971.75028249767;25089.49821003606;25164.112691548573;25170.496590068462 10:53:58 INFO - PROCESS | 25468 | |2;jquery.html;340.833655341874;362.78776915504426;368.0944875606009;371.63579691901924;385.6798856948733;12944.676383090416;16382.508524744262;16529.66940661186;17605.383811566597;17734.201960911756;16412.425565105194;16505;16867.662646747056;17064.48806535806;17074.402395916146;4901.754912254391;5011.574016208627;5167.664101833388;5179.300794392765;5184.585233181337;3725.2549490102087;5082.161443361841;5164.561012313958;5687.516561092291;6008;6012.428819262163;6044.063170208603;6049.546284028694;6050.2437195350585;6052.818415447544;5134.563562097245;5381.650192737459;5400.78396864125;5475.863103422406;6029.1257767623665;5292.285541451932;5310.36275646921;5314.441983591744;5318.946810531884;5321.175217841241;11991.16061875669;12036.39818009096;12249.387530623433;12353.258804471761;12377.443015064344;1865.4776662534377;1868.813118688134;1921.2027008791335;1931.1020375525447;1932.3623204342673;8621;8945.59744811485;9308.767280817967;9518.95240523793;9536.2371010319;1707.4621494229277;1736.079877664827;1745.9388921387817;1763.3034951194334;1795.6532600549588;45866.77066614679;61719.38280617226;65841;76565;78633.67514786684;15159.545213643609;16326.673466530603;16602.916985414995;16662.83337166613;16774.39996800498;30118.397632047236;30132.698673013427;30143.09570712882;30148.698513015028;30170.49147542614;8342.791430214173;8890.59992300348;9011.684591039413;9138.54307284633;9149.268058555299;7404.259574042552;7601.163871974079;7689.231076892378;7724.729634462767;8007.559584222807;8450.408471406943;8584;8643.481391116553;8662.91713535808;8735.956320218485;2674.8127631066027;3208.5668434761474;3332.250243695149;3348.983255083709;3381.03640462467;811.6509900742619;858.6264974735885;896.587569717924;899.6581299106298;971.582219645545;16513.504594862174;17033.7444938326;17705.468835934942;17785.822141778415;18070.18684159216;845.5434065604504;862.607513581319;871.6034204436966;881.9382643215042;888.9911100889037;9572.425654460616;10077.395356278646;10115.291929564859;10120.696379108638;10176.542055607515;385651;386977;392489;398555;399189;46179.5382046182;46585.53414465812;79938;80622.19377806265;81005.59497202476;902.6885724425194;921.1847514949184;935.6538080910107;935.6725146198912;939.9342046056711;15543.145127018122;15673.451429199924;16087.597810054374;16307.429239976544;16486.505404837873;26956.865215673795;37596.812015939744;39180.2163956725;39309.41035884407;39482.2103557933;52039.479605203465;52278.47721522736;52356.47643523516;53502.1974670388;53611;7043.908194229903;7155.606441645759;7380.852382952418;7434.553926764412;7840.568768717775;10894.400807955639;10946.39794811293;11100.444977751242;11270.422140900117;11324.207305488537;9594.616215351587;9695.321327507007;9756.560954756911;10033.648822291185;10163.796724065625;9449;10123;10233.130183934449;10278.537465813906;10343.431111288952;9328.860067098864;9574.329796914428;9696.660616878658;9879.851802223116;10205.59177632916;7296.671649775667;7406.44451666138;7500.512466689648;7565.546067235983;7767.339776118867;8340.833183336421;9471.47906865129;9508.857367139637;9748.951255243679;10318.226133039901 10:53:58 INFO - PROCESS | 25468 | |3;mootools.html;1336.2450215628169;1393.9963226476937;1420.2259768426206;1659.809121950976;1676.044654546908;7045.5772653640815;7569.735059272926;7575.659095340709;7579.696812127509;7597.962010189955;6540.084388185658;7130.073090498228;7290.198078211406;7356.485046046779;7477.401807855372;2080.4694802825256;2106.1049054152;2111.2927169398195;2112.6197284488785;2114.143771772435;2068.4778711707786;2099.496120930973;2146.828253739705;2149.9570008599817;2154.3213887625425;1838.209569884949;2073.3779866040204;2131.6482780341225;2132.861364011342;2142.817860481861;2141.5716856628737;2148.7851214878465;2165.2746329979477;2168.8915554222385;2171.392010237136;2075.138817390781;2111.9049642766113;2112.4718820294925;2112.7675955645022;2116.1323857218467;7213.134423869169;7275.4179665626625;7277.053982982231;7280.781576552712;7281.162666293391;4226.725262857904;4357.673174511924;4361.5856493633055;4364.388985542027;4372.781360931941;2710.2953232159584;2796.5245908195657;2821.435712857416;2832.6459192600923;2849.5155823509845;902.5442151713409;937.9015203403612;962.4225464721181;963.6145541783272;968.2060710217625;9984.400935943793;10001.549930253155;10012.499375031219;10012.849807252824;10031.74920626983;3849.1531862990096;3960.7029472789654;4087.713860029829;4171.812268447927;4177.078543869793;8672.6530938763;8682.262007729414;8690.348223883235;8710.912890871137;8714.433561818461;4388.670849686287;4394.2969124939855;4398.670099742532;4399.604035636744;4399.802008909607;3924.4898163238595;3946.6645335146836;3951.604839516083;3970.4441378207075;3972.7616343019513;3520.8767693130617;3611.5485564304463;3629.1108678373967;3669.027707657473;3669.412893936957;1172.0857730969858;1176.7646470705893;1185.857697076339;1202.6151631477844;1202.8135638975973;616.6454288783967;738.1953670499182;807.8182408958055;841.6128580852876;846.3187134356779;5063.544281014726;5192.636515443958;5202.583793296527;5254.2118682197215;5432.158015507603;790.6086487188878;857.2927334948693;858.7419430534297;860.4450129666455;887.5606574745542;3788.6969042476535;3882.650561449483;3888.902777430587;3936.527616685959;3943.645071943539;8983.416077955042;9324;9327.860082098774;9336.673216437528;9339.299552533586;9241.861372079424;9246.907530924605;9279.350445468752;9281.860772088425;9290.860637090449;6859.828504287433;7083;7087.149542054884;7107.573545587178;7107.644617769194;5124.590032797441;5362.222477740784;5403.270558474555;5430.83707488776;5597.80407685729;8579.871301930601;8581.227689507974;8610.095939926468;8625.137486251324;8677.566121694017;8017.599120044091;8349.791255218668;8359.749207523784;8576.828463430822;8727.956360218159;6373.521985850987;6526.086347911391;6545.770898018546;6554.63949482783;6555.672216389257;6880.0711903894335;6905.930940690529;6920.653967301715;6922.1001269836615;6929.341712537301;6425.807225783234;6488.870222595428;6492.220933488012;6537.542372033912;6669.299723529154;6269.937300626935;6407.135036769976;6407.391297826885;6433.035044743326;6482.70827812759;6060.181875446759;6161.075838624242;6165.537584681257;6168.074788781719;6173.475254603409;4360.847370342023;4366.694331396771;4430.645548356059;4544.545545445429;4644.37300964379;4421.513633500248;4574.951492146429;4587.587117159472;4650.37219975299;4667.766611669471 10:53:58 INFO - PROCESS | 25468 | |4;prototype.html;288.420275246754;289.51795260890617;300.27633403497566;301.03368188116144;301.13724180223653;4804.279358096287;4831.4685384607665;4834.444038935523;4863.829765958192;4887.584555312798;4786.664933454659;4800.447948485925;4801.951980480194;4814.7351895645725;4824.215040435035;3820.739156078487;3839.731218814684;3843.711721620876;3850.152966347399;3857.8263978121054;3553.3426316131468;3607.8376473058643;3844.884653460401;3853.614638536152;3857.189990102082;3149.7165255127034;3648.8289467766635;3652.853885844563;3655.689266412358;3775.7168212384045;3615.963840361589;3762.435634654796;3765.3034188675047;3777.301199278142;3784.394496880486;3340.832958352097;3342.9331413371597;3343.8996830095134;3346.330733853215;3350.4136776064092;4483.170613436525;4548.749818759967;4630.268141796322;4703.002447919275;4732.692374995649;4288.378185163165;4290.442242508485;4292.849750258726;4313.986213239886;4322.265214913472;5024.572911302544;5029.8934234468725;5030.346055012825;5035.54680078791;5045.772940217699;3542.256126213498;3615.6745892869767;3624.6439814120768;3633.909152271188;3653.4337177737493;5226.817061402832;5227.477252274742;5228.241904923802;5233.764480598382;5242.7116508591635;3718.330700473941;3719.274741425396;3730.477733117366;3733.8693145739767;3744.202782664336;3696.2053158571034;3763.6236376362144;3789.2610940866816;3791.962080379216;3810.1998580297895;4257.510386305615;4266.829326826892;4274.679399045084;4283.550227226158;4289;4992.900141997213;4996.525330093636;5005.899882002413;5006.824761133343;5034.723090230073;1283.775339315616;1287.9162854414433;1294.5469085819889;1297.9091463597458;1302.2707283921034;904.674317245791;917.3395155488038;918.9632414703337;923.1091996223677;923.5382308845577;4401.779911004501;4410.933835992462;4413.933790993137;4435.711678740936;4437.755923424178;5132.3327967364;5139.897202055938;5153.948460515347;5154.690718556899;5161.503164082449;4280.67894907877;4401.757903315284;4426.800793964279;4438.223310920576;4447.955520444819;2410.81918856083;2435.8173137014796;2441.0357908626347;2444.987775061113;2448.6939132608422;4250.404943307939;4318.222719910446;4318.978405108017;4319.444999800069;4618.65360097994;4681.344611754357;5168.095583272912;5183.974080129575;5204;5206.973965130226;4804.159272127434;4833.419989601271;4881.242098214498;4895.583875370633;4896.975515122402;5132.409772876018;5155.9742201288755;5161.690298582097;5165.328507294028;5189.4032186299055;4815.855524334275;5046.57104146137;5057.898842023213;5082.644214904921;5084.466131056334;4867.756612169306;4881.339669879853;4909.3126962224605;4912.1158191525865;4930.654854160318;3627.383344831332;3627.927441451209;3646.6717995380545;3661.2860492203763;3664.992127165051;5086.660136337327;5219.416388887525;5221.660592061504;5223.52988231061;5243.895122097613;5019;5034.14419548685;5037.4887533739;5047.369078865142;5051.520105589963;5026.899462010812;5037.722925239147;5037.974810125926;5047.167217409086;5048.217526283432;4762.9285560715925;4962;4974.427940786711;4982.950170498249;4984.17761069434;5037.345145131109;5060.114479965918;5060.3927528696795;5062.696238225718;5070.5943524517215;4893.877653058702;4976.536614375907;4976.8755781105765;4986.626003049858;4988.152014157529 10:53:58 INFO - PROCESS | 25468 | |5;yui.html;628.767356078251;666.0209492046693;677.6171463123331;711.1182134153648;731.5135434935767;12116.212446191003;13629.386677599507;13648.795268070988;13687.931560342196;13710.24593647349;13653.590392288223;13728.931355343235;13754.72490550191;13803.171809691425;13815.861841381584;626.5363630913114;761.1969372312209;769.0886299734805;787.9054513458393;787.9409044321699;781.03932163439;787.3032366355787;787.401574803148;791.3945831438954;792.0258082558456;834.1158372125536;835.3484282259847;835.5613303015934;836.0302049622439;836.2139588786521;658.2200092889941;806.6491076381793;831.8128421105264;831.8793774902636;832.2800777327568;601.9006863867501;603.0200923499314;603.0532064658488;604.2054698072021;604.7339170764849;13083.084184107116;13083.280419576919;13095.410706518229;13098.803517947143;13100.410481528354;13514.189148651112;13622.18266903979;14013.159210447304;14040.157590544497;14356.712865742627;10488.265821392506;10668.893311066868;10693.518791654395;10999.23005389623;11096.889031109748;3292.9176770580925;3294.6540613235506;3299.4555898276753;3323.135984643986;3384.1539615096226;64465;65349.34650653528;66606;67358.66320668414;68163;10947.288426252268;10957.17821163416;10962.671119866416;11114.11087113029;11335.03652189573;20956.266530671353;21072.789272107388;21176.682349764767;21214.681779773317;21438;7012.719491220294;7031.542949708252;7040.155181378165;7263.418926485974;7444.813879652944;3755.7183211259266;3802.068493219179;3834.884953451401;3889.78606176663;3902.804859757001;2920.8685609147637;3022.7732920031085;3041.6045914031033;3050.847457627154;3056.847157642109;478.3972195034282;479.5827629961886;483.16894940701934;491.2753688309786;498.30486471372234;572.4876235769046;608.8964875971006;621.8456656170727;628.2680677011322;633.0630666613438;8039.437239393186;8199.180081991872;8213.589320533949;8306.750797475965;8399.28606068491;512.5617596954625;576.6972339521784;591.9940800592025;598.9550783691241;601.5969300568629;4026.5168179818024;4177.3316269397355;4231.344141658048;4327.610515053598;4451.5103338632725;95183;101381.49309253406;102076;104385;104790.47604761928;51140;51459;78547.21452785513;89342.55328723315;91949.54025229964;45361;45787.31319030217;75138.62430687812;76159.61920190364;76853.6157319221;7269.454790890599;7730.7680769577;7929.563873986986;8125.187481251827;8194.385421093322;32552.83723581367;37099.17710697592;42328;43447.565524344354;46251.21859767529;58920.41079589149;63816.68091659512;64594.67702661457;64631;65014;10043.347182433119;10125.443100629242;10495.947520262349;10962.287451315638;11745.941270293593;12402.441890114786;13319.66700832487;13562.728745425233;13679.247641379421;14233.430662773373;11809.645710628694;12071.326506310916;12198.390080495763;12379.93810030944;12599.370031498573;12114.636560903187;12225.37559291063;12425.502979880703;12553.058520611174;12647.747045058863;12531.373431328579;12778.169418987736;12841;13060.346982651019;13169.670758230737;10155.7461063474;10585.788284234119;10715.142788577052;10716.517756701123;11109.722256943642;8625.568721564023;9921.305508614329;10589.417582033062;10686.83969740439;10707.625233116803 10:53:58 INFO - PROCESS | 25468 | __end_tp_report 10:53:58 INFO - PROCESS | 25468 | __start_cc_report 10:53:58 INFO - PROCESS | 25468 | _x_x_mozilla_cycle_collect,1058 10:53:58 INFO - PROCESS | 25468 | __end_cc_report 10:53:58 INFO - PROCESS | 25468 | __startTimestamp1470246838595__endTimestamp 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | ------- Summary: start ------- 10:53:58 INFO - PROCESS | 25468 | Number of tests: 6 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#0] dojo.html Cycles:165 Average:4766.07 Median:4871.68 stddev:510.80 (10.5%) stddev-sans-first:485.41 10:53:58 INFO - PROCESS | 25468 | Values: 2678.6 2695.6 2703.5 2721.3 2725.1 4639.6 4707.4 4798.5 4873.9 4881.8 4768.5 4805.6 4816.8 4826.6 4909.5 4417.1 4454.2 4487.3 4508.5 4599.0 4529.1 4544.6 4559.4 4559.5 4567.1 4293.1 4341.8 4344.4 4478.7 4510.1 4375.5 4396.5 4402.6 4404.0 4419.7 4409.9 4432.2 4433.5 4433.7 4438.1 4788.2 4795.3 4795.7 4851.7 4910.8 5126.6 5211.1 5227.9 5293.5 5299.6 5327.1 5329.7 5331.9 5332.3 5336.6 4692.7 4752.2 4800.9 4808.4 4871.6 5298.3 5334.8 5345.9 5363.1 5366.6 5084.7 5091.7 5126.9 5134.2 5136.5 4831.3 5124.4 5139.4 5141.3 5217.5 5093.9 5106.7 5115.9 5122.7 5124.9 5101.5 5104.0 5104.1 5104.9 5136.8 4059.1 4080.2 4086.5 4139.0 4236.6 3792.4 3799.0 3847.2 3861.1 3874.4 4439.3 4452.7 4458.8 4495.7 4511.9 4927.1 5092.0 5243.7 5249.7 5251.7 4385.9 4436.8 4446.2 4480.7 4485.7 4650.1 4650.6 4650.9 4691.9 4696.4 4726.5 4846.4 4848.0 4893.0 4898.5 5177.7 5194.2 5202.0 5247.4 5253.8 4834.5 4840.6 4866.1 4922.6 4922.9 4871.7 5025.5 5116.0 5123.9 5142.6 5124.7 5176.5 5188.1 5212.4 5220.8 5008.7 5010.7 5019.5 5022.7 5066.2 4765.3 4945.3 5004.4 5017.0 5017.9 4898.5 4988.0 4997.1 4997.8 5003.2 5035.9 5046.9 5048.7 5049.4 5097.9 4798.9 4846.1 4848.3 4938.6 4950.1 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#1] ext.html Cycles:180 Average:46818.10 Median:34460.07 stddev:86742.93 (251.7%) stddev-sans-first:86916.73 10:53:58 INFO - PROCESS | 25468 | Values: 557.0 564.9 568.6 575.5 576.0 28383.9 38654.8 40101.6 40163.8 44520.0 40076.6 40387.0 40398.0 40515.0 40785.2 7282.4 7650.0 7775.7 7800.8 7801.1 9696.9 9983.3 9995.8 10393.8 10398.6 10074.6 10176.7 10184.2 10184.8 10185.9 9951.3 9997.6 10017.3 10018.6 10024.7 9715.3 9772.6 9776.7 9786.4 9786.6 37858.0 38015.8 38040.8 38067.2 38083.6 3064.3 3182.9 3350.3 3650.1 3723.6 29752.9 29849.6 30179.0 30559.0 30672.8 3238.3 3317.6 3326.3 3388.2 3466.2 242630.0 243261.0 243484.0 243585.0 244276.0 31940.4 32944.8 32962.8 53182.0 53538.7 34159.7 34239.3 34324.3 34380.1 34384.5 13224.4 13430.3 13480.5 13489.5 13491.7 9993.8 10647.3 10769.7 10947.3 10999.7 8017.7 8021.1 8051.5 8115.7 8120.8 3069.5 3089.3 3094.9 3135.6 3160.8 899.7 905.3 928.0 963.9 1029.9 27455.5 29287.6 29305.6 29376.8 29757.1 950.7 961.1 962.0 1007.4 1031.2 15069.8 15174.2 15430.4 15664.5 15714.4 402010.0 405892.0 406232.0 406585.0 406661.0 48978.3 49462.0 49549.0 49565.5 49605.8 1067.6 1181.1 1184.2 1197.3 1206.9 28033.4 29129.7 29277.9 29370.3 29955.6 43014.6 43557.6 43560.6 43724.0 43732.8 314305.0 318009.0 318170.0 318284.0 318488.0 25337.5 25932.7 25941.2 27018.5 27133.7 42291.6 42436.8 42450.2 42540.4 42627.8 35528.8 36029.3 36222.5 36654.3 36659.5 35796.6 36377.6 36384.8 36553.3 36769.6 35521.8 35730.3 35744.0 36850.1 39207.8 32251.4 34016.7 34443.7 34476.5 34476.7 24901.8 24971.8 25089.5 25164.1 25170.5 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#2] jquery.html Cycles:180 Average:24612.08 Median:5166.11 stddev:64579.14 (1250.1%) stddev-sans-first:64734.59 10:53:58 INFO - PROCESS | 25468 | Values: 340.8 362.8 368.1 371.6 385.7 12944.7 16382.5 16529.7 17605.4 17734.2 16412.4 16505.0 16867.7 17064.5 17074.4 4901.8 5011.6 5167.7 5179.3 5184.6 3725.3 5082.2 5164.6 5687.5 6008.0 6012.4 6044.1 6049.5 6050.2 6052.8 5134.6 5381.7 5400.8 5475.9 6029.1 5292.3 5310.4 5314.4 5318.9 5321.2 11991.2 12036.4 12249.4 12353.3 12377.4 1865.5 1868.8 1921.2 1931.1 1932.4 8621.0 8945.6 9308.8 9519.0 9536.2 1707.5 1736.1 1745.9 1763.3 1795.7 45866.8 61719.4 65841.0 76565.0 78633.7 15159.5 16326.7 16602.9 16662.8 16774.4 30118.4 30132.7 30143.1 30148.7 30170.5 8342.8 8890.6 9011.7 9138.5 9149.3 7404.3 7601.2 7689.2 7724.7 8007.6 8450.4 8584.0 8643.5 8662.9 8736.0 2674.8 3208.6 3332.3 3349.0 3381.0 811.7 858.6 896.6 899.7 971.6 16513.5 17033.7 17705.5 17785.8 18070.2 845.5 862.6 871.6 881.9 889.0 9572.4 10077.4 10115.3 10120.7 10176.5 385651.0 386977.0 392489.0 398555.0 399189.0 46179.5 46585.5 79938.0 80622.2 81005.6 902.7 921.2 935.7 935.7 939.9 15543.1 15673.5 16087.6 16307.4 16486.5 26956.9 37596.8 39180.2 39309.4 39482.2 52039.5 52278.5 52356.5 53502.2 53611.0 7043.9 7155.6 7380.9 7434.6 7840.6 10894.4 10946.4 11100.4 11270.4 11324.2 9594.6 9695.3 9756.6 10033.6 10163.8 9449.0 10123.0 10233.1 10278.5 10343.4 9328.9 9574.3 9696.7 9879.9 10205.6 7296.7 7406.4 7500.5 7565.5 7767.3 8340.8 9471.5 9508.9 9749.0 10318.2 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#3] mootools.html Cycles:180 Average:4950.32 Median:5417.05 stddev:2711.55 (50.1%) stddev-sans-first:2705.55 10:53:58 INFO - PROCESS | 25468 | Values: 1336.2 1394.0 1420.2 1659.8 1676.0 7045.6 7569.7 7575.7 7579.7 7598.0 6540.1 7130.1 7290.2 7356.5 7477.4 2080.5 2106.1 2111.3 2112.6 2114.1 2068.5 2099.5 2146.8 2150.0 2154.3 1838.2 2073.4 2131.6 2132.9 2142.8 2141.6 2148.8 2165.3 2168.9 2171.4 2075.1 2111.9 2112.5 2112.8 2116.1 7213.1 7275.4 7277.1 7280.8 7281.2 4226.7 4357.7 4361.6 4364.4 4372.8 2710.3 2796.5 2821.4 2832.6 2849.5 902.5 937.9 962.4 963.6 968.2 9984.4 10001.5 10012.5 10012.8 10031.7 3849.2 3960.7 4087.7 4171.8 4177.1 8672.7 8682.3 8690.3 8710.9 8714.4 4388.7 4394.3 4398.7 4399.6 4399.8 3924.5 3946.7 3951.6 3970.4 3972.8 3520.9 3611.5 3629.1 3669.0 3669.4 1172.1 1176.8 1185.9 1202.6 1202.8 616.6 738.2 807.8 841.6 846.3 5063.5 5192.6 5202.6 5254.2 5432.2 790.6 857.3 858.7 860.4 887.6 3788.7 3882.7 3888.9 3936.5 3943.6 8983.4 9324.0 9327.9 9336.7 9339.3 9241.9 9246.9 9279.4 9281.9 9290.9 6859.8 7083.0 7087.1 7107.6 7107.6 5124.6 5362.2 5403.3 5430.8 5597.8 8579.9 8581.2 8610.1 8625.1 8677.6 8017.6 8349.8 8359.7 8576.8 8728.0 6373.5 6526.1 6545.8 6554.6 6555.7 6880.1 6905.9 6920.7 6922.1 6929.3 6425.8 6488.9 6492.2 6537.5 6669.3 6269.9 6407.1 6407.4 6433.0 6482.7 6060.2 6161.1 6165.5 6168.1 6173.5 4360.8 4366.7 4430.6 4544.5 4644.4 4421.5 4575.0 4587.6 4650.4 4667.8 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#4] prototype.html Cycles:180 Average:4157.32 Median:4747.81 stddev:1209.58 (25.5%) stddev-sans-first:1177.60 10:53:58 INFO - PROCESS | 25468 | Values: 288.4 289.5 300.3 301.0 301.1 4804.3 4831.5 4834.4 4863.8 4887.6 4786.7 4800.4 4802.0 4814.7 4824.2 3820.7 3839.7 3843.7 3850.2 3857.8 3553.3 3607.8 3844.9 3853.6 3857.2 3149.7 3648.8 3652.9 3655.7 3775.7 3616.0 3762.4 3765.3 3777.3 3784.4 3340.8 3342.9 3343.9 3346.3 3350.4 4483.2 4548.7 4630.3 4703.0 4732.7 4288.4 4290.4 4292.8 4314.0 4322.3 5024.6 5029.9 5030.3 5035.5 5045.8 3542.3 3615.7 3624.6 3633.9 3653.4 5226.8 5227.5 5228.2 5233.8 5242.7 3718.3 3719.3 3730.5 3733.9 3744.2 3696.2 3763.6 3789.3 3792.0 3810.2 4257.5 4266.8 4274.7 4283.6 4289.0 4992.9 4996.5 5005.9 5006.8 5034.7 1283.8 1287.9 1294.5 1297.9 1302.3 904.7 917.3 919.0 923.1 923.5 4401.8 4410.9 4413.9 4435.7 4437.8 5132.3 5139.9 5153.9 5154.7 5161.5 4280.7 4401.8 4426.8 4438.2 4448.0 2410.8 2435.8 2441.0 2445.0 2448.7 4250.4 4318.2 4319.0 4319.4 4618.7 4681.3 5168.1 5184.0 5204.0 5207.0 4804.2 4833.4 4881.2 4895.6 4897.0 5132.4 5156.0 5161.7 5165.3 5189.4 4815.9 5046.6 5057.9 5082.6 5084.5 4867.8 4881.3 4909.3 4912.1 4930.7 3627.4 3627.9 3646.7 3661.3 3665.0 5086.7 5219.4 5221.7 5223.5 5243.9 5019.0 5034.1 5037.5 5047.4 5051.5 5026.9 5037.7 5038.0 5047.2 5048.2 4762.9 4962.0 4974.4 4983.0 4984.2 5037.3 5060.1 5060.4 5062.7 5070.6 4893.9 4976.5 4976.9 4986.6 4988.2 10:53:58 INFO - PROCESS | 25468 | 10:53:58 INFO - PROCESS | 25468 | [#5] yui.html Cycles:180 Average:17536.25 Median:4204.34 stddev:24707.33 (587.7%) stddev-sans-first:24744.02 10:53:58 INFO - PROCESS | 25468 | Values: 628.8 666.0 677.6 711.1 731.5 12116.2 13629.4 13648.8 13687.9 13710.2 13653.6 13728.9 13754.7 13803.2 13815.9 626.5 761.2 769.1 787.9 787.9 781.0 787.3 787.4 791.4 792.0 834.1 835.3 835.6 836.0 836.2 658.2 806.6 831.8 831.9 832.3 601.9 603.0 603.1 604.2 604.7 13083.1 13083.3 13095.4 13098.8 13100.4 13514.2 13622.2 14013.2 14040.2 14356.7 10488.3 10668.9 10693.5 10999.2 11096.9 3292.9 3294.7 3299.5 3323.1 3384.2 64465.0 65349.3 66606.0 67358.7 68163.0 10947.3 10957.2 10962.7 11114.1 11335.0 20956.3 21072.8 21176.7 21214.7 21438.0 7012.7 7031.5 7040.2 7263.4 7444.8 3755.7 3802.1 3834.9 3889.8 3902.8 2920.9 3022.8 3041.6 3050.8 3056.8 478.4 479.6 483.2 491.3 498.3 572.5 608.9 621.8 628.3 633.1 8039.4 8199.2 8213.6 8306.8 8399.3 512.6 576.7 592.0 599.0 601.6 4026.5 4177.3 4231.3 4327.6 4451.5 95183.0 101381.5 102076.0 104385.0 104790.5 51140.0 51459.0 78547.2 89342.6 91949.5 45361.0 45787.3 75138.6 76159.6 76853.6 7269.5 7730.8 7929.6 8125.2 8194.4 32552.8 37099.2 42328.0 43447.6 46251.2 58920.4 63816.7 64594.7 64631.0 65014.0 10043.3 10125.4 10495.9 10962.3 11745.9 12402.4 13319.7 13562.7 13679.2 14233.4 11809.6 12071.3 12198.4 12379.9 12599.4 12114.6 12225.4 12425.5 12553.1 12647.7 12531.4 12778.2 12841.0 13060.3 13169.7 10155.7 10585.8 10715.1 10716.5 11109.7 8625.6 9921.3 10589.4 10686.8 10707.6 10:53:58 INFO - PROCESS | 25468 | -------- Summary: end -------- 10:53:58 INFO - PROCESS | 25468 | 10:53:59 INFO - TEST-INFO | 25468: exit 0 10:53:59 INFO - TEST-OK | dromaeo_css | took 1121267ms 10:53:59 INFO - TEST-START | kraken 10:53:59 INFO - operating with platform_type : linux_ 10:53:59 INFO - Initialising browser for kraken test... 10:53:59 INFO - TEST-INFO | started process 25655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfIEl2S/profile http://localhost:36484/getInfo.html) 10:54:03 INFO - PROCESS | 25655 | __metrics Screen width/height:1600/1200 10:54:03 INFO - PROCESS | 25655 | colorDepth:24 10:54:03 INFO - PROCESS | 25655 | Browser inner width/height: 1024/697 10:54:03 INFO - PROCESS | 25655 | __metrics 10:54:04 INFO - PROCESS | 25655 | 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" 10:54:04 INFO - PROCESS | 25655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:05 INFO - TEST-INFO | 25655: exit 0 10:54:05 INFO - Browser initialized. 10:54:05 INFO - Running cycle 1/1 for kraken test... 10:54:05 INFO - TEST-INFO | started process 25736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfIEl2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:17 INFO - PROCESS | 25736 | RSS: Main: 157691904 10:54:17 INFO - PROCESS | 25736 | 10:54:20 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36484/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:21 INFO - PROCESS | 25736 | RSS: Main: 214102016 10:54:21 INFO - PROCESS | 25736 | 10:54:23 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36484/tests/kraken/driver.html?testName=audio-dft) 10:54:24 INFO - PROCESS | 25736 | RSS: Main: 191578112 10:54:24 INFO - PROCESS | 25736 | 10:54:27 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36484/tests/kraken/driver.html?testName=audio-fft) 10:54:28 INFO - PROCESS | 25736 | RSS: Main: 271523840 10:54:28 INFO - PROCESS | 25736 | 10:54:30 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36484/tests/kraken/driver.html?testName=audio-oscillator) 10:54:31 INFO - PROCESS | 25736 | RSS: Main: 181112832 10:54:31 INFO - PROCESS | 25736 | 10:54:33 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:33 INFO - PROCESS | 25736 | RSS: Main: 185446400 10:54:33 INFO - PROCESS | 25736 | 10:54:37 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36484/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:37 INFO - PROCESS | 25736 | RSS: Main: 221347840 10:54:37 INFO - PROCESS | 25736 | 10:54:41 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36484/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:41 INFO - PROCESS | 25736 | RSS: Main: 215502848 10:54:41 INFO - PROCESS | 25736 | 10:54:44 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36484/tests/kraken/driver.html?testName=json-parse-financial) 10:54:45 INFO - PROCESS | 25736 | RSS: Main: 218828800 10:54:45 INFO - PROCESS | 25736 | 10:54:47 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:47 INFO - PROCESS | 25736 | RSS: Main: 185102336 10:54:47 INFO - PROCESS | 25736 | 10:54:49 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:50 INFO - PROCESS | 25736 | RSS: Main: 190672896 10:54:50 INFO - PROCESS | 25736 | 10:54:52 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:53 INFO - PROCESS | 25736 | RSS: Main: 194232320 10:54:53 INFO - PROCESS | 25736 | 10:54:55 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:56 INFO - PROCESS | 25736 | RSS: Main: 189751296 10:54:56 INFO - PROCESS | 25736 | 10:54:59 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:00 INFO - PROCESS | 25736 | RSS: Main: 193003520 10:55:00 INFO - PROCESS | 25736 | 10:55:01 INFO - PROCESS | 25736 | Cycle 1(1): loaded http://localhost:36484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36484/tests/kraken/driver.html?testName=ai-astar) 10:55:02 INFO - PROCESS | 25736 | RSS: Main: 243425280 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | __start_tp_report 10:55:02 INFO - PROCESS | 25736 | _x_x_mozilla_page_load 10:55:02 INFO - PROCESS | 25736 | _x_x_mozilla_page_load_details 10:55:02 INFO - PROCESS | 25736 | |i|pagename|runs| 10:55:02 INFO - PROCESS | 25736 | |0;ai-astar;105;113;114;115;115;115;114;114;112;114 10:55:02 INFO - PROCESS | 25736 | |1;audio-beat-detection;152;121;124;184;123;125;153;121;165;122 10:55:02 INFO - PROCESS | 25736 | |2;audio-dft;161;161;162;160;162;161;159;161;164;161 10:55:02 INFO - PROCESS | 25736 | |3;audio-fft;76;76;75;123;75;76;75;77;104;76 10:55:02 INFO - PROCESS | 25736 | |4;audio-oscillator;85;87;128;86;86;87;117;85;86;130 10:55:02 INFO - PROCESS | 25736 | |5;imaging-gaussian-blur;118;117;117;116;117;117;116;117;116;116 10:55:02 INFO - PROCESS | 25736 | |6;imaging-darkroom;146;146;147;146;146;147;147;146;147;148 10:55:02 INFO - PROCESS | 25736 | |7;imaging-desaturate;95;95;96;97;96;94;95;94;95;96 10:55:02 INFO - PROCESS | 25736 | |8;json-parse-financial;67;64;69;65;65;65;65;66;66;64 10:55:02 INFO - PROCESS | 25736 | |9;json-stringify-tinderbox;65;66;66;66;66;66;76;65;66;67 10:55:02 INFO - PROCESS | 25736 | |10;stanford-crypto-aes;79;79;80;89;83;81;79;79;78;79 10:55:02 INFO - PROCESS | 25736 | |11;stanford-crypto-ccm;134;137;140;138;131;139;133;137;167;134 10:55:02 INFO - PROCESS | 25736 | |12;stanford-crypto-pbkdf2;167;169;164;173;175;167;165;168;167;165 10:55:02 INFO - PROCESS | 25736 | |13;stanford-crypto-sha256-iterative;70;68;68;69;70;67;67;67;66;66 10:55:02 INFO - PROCESS | 25736 | __end_tp_report 10:55:02 INFO - PROCESS | 25736 | __start_cc_report 10:55:02 INFO - PROCESS | 25736 | _x_x_mozilla_cycle_collect,1918 10:55:02 INFO - PROCESS | 25736 | __end_cc_report 10:55:02 INFO - PROCESS | 25736 | __startTimestamp1470246902086__endTimestamp 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | ------- Summary: start ------- 10:55:02 INFO - PROCESS | 25736 | Number of tests: 14 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.00 (2.6%) stddev-sans-first:1.00 10:55:02 INFO - PROCESS | 25736 | Values: 105.0 113.0 114.0 115.0 115.0 115.0 114.0 114.0 112.0 114.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:138.50 stddev:22.80 (16.5%) stddev-sans-first:23.70 10:55:02 INFO - PROCESS | 25736 | Values: 152.0 121.0 124.0 184.0 123.0 125.0 153.0 121.0 165.0 122.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 10:55:02 INFO - PROCESS | 25736 | Values: 161.0 161.0 162.0 160.0 162.0 161.0 159.0 161.0 164.0 161.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.55 (21.8%) stddev-sans-first:17.34 10:55:02 INFO - PROCESS | 25736 | Values: 76.0 76.0 75.0 123.0 75.0 76.0 75.0 77.0 104.0 76.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:86.00 stddev:19.14 (22.3%) stddev-sans-first:19.74 10:55:02 INFO - PROCESS | 25736 | Values: 85.0 87.0 128.0 86.0 86.0 87.0 117.0 85.0 86.0 130.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 10:55:02 INFO - PROCESS | 25736 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:55:02 INFO - PROCESS | 25736 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 148.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 10:55:02 INFO - PROCESS | 25736 | Values: 95.0 95.0 96.0 97.0 96.0 94.0 95.0 94.0 95.0 96.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.50 stddev:1.51 (2.3%) stddev-sans-first:1.51 10:55:02 INFO - PROCESS | 25736 | Values: 67.0 64.0 69.0 65.0 65.0 65.0 65.0 66.0 66.0 64.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.00 stddev:3.25 (4.9%) stddev-sans-first:3.37 10:55:02 INFO - PROCESS | 25736 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 76.0 65.0 66.0 67.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.27 (4.1%) stddev-sans-first:3.42 10:55:02 INFO - PROCESS | 25736 | Values: 79.0 79.0 80.0 89.0 83.0 81.0 79.0 79.0 78.0 79.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:137.50 stddev:10.24 (7.4%) stddev-sans-first:10.70 10:55:02 INFO - PROCESS | 25736 | Values: 134.0 137.0 140.0 138.0 131.0 139.0 133.0 137.0 167.0 134.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:167.50 stddev:3.53 (2.1%) stddev-sans-first:3.72 10:55:02 INFO - PROCESS | 25736 | Values: 167.0 169.0 164.0 173.0 175.0 167.0 165.0 168.0 167.0 165.0 10:55:02 INFO - PROCESS | 25736 | 10:55:02 INFO - PROCESS | 25736 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.33 10:55:02 INFO - PROCESS | 25736 | Values: 70.0 68.0 68.0 69.0 70.0 67.0 67.0 67.0 66.0 66.0 10:55:02 INFO - PROCESS | 25736 | -------- Summary: end -------- 10:55:02 INFO - PROCESS | 25736 | 10:55:03 INFO - TEST-INFO | 25736: exit 0 10:55:03 INFO - TEST-OK | kraken | took 63847ms 10:55:03 INFO - SUITE-END | took 1185s 10:55:03 INFO - Completed test suite (00:19:45) 10:55:03 INFO - javascript benchmark 10:55:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.62499250105, 2695.6091366751807, 2703.4863375958566, 2721.3332733480293, 2725.100716763467, 4639.559241872017, 4707.388039554853, 4798.520147985199, 4873.902521949559, 4881.804727810888, 4768.475467698559, 4805.567498925096, 4816.783244753986, 4826.638002149835, 4909.459959404463, 4417.138657961698, 4454.175977444167, 4487.349334346518, 4508.458984921814, 4598.97700511497, 4529.116822219668, 4544.613707834838, 4559.407277053979, 4559.475660299058, 4567.08658268346, 4293.076988447468, 4341.826326946918, 4344.391785150082, 4478.708883922567, 4510.0979804039325, 4375.540568240321, 4396.472423309224, 4402.603765661074, 4404.0, 4419.734815911055, 4409.933850992237, 4432.246518091933, 4433.490148632916, 4433.689641725081, 4438.090191510732, 4788.209945359012, 4795.2807078938085, 4795.736234507101, 4851.660383773137, 4910.803567857317, 5126.61550383719, 5211.062008838408, 5227.869303267411, 5293.470652934676, 5299.5760339172775, 5327.147656375, 5329.706866122362, 5331.866703332409, 5332.253484512172, 5336.573074154058, 4692.694974826625, 4752.239641657318, 4800.903981920342, 4808.447028591757, 4871.585915197177, 5298.258243845865, 5334.839954801362, 5345.866353341197, 5363.115086010843, 5366.597505187126, 5084.694918304914, 5091.719955402488, 5126.871828204325, 5134.229865520202, 5136.5377116059735, 4831.347768051339, 5124.385073791094, 5139.408967968731, 5141.25451809493, 5217.530422262014, 5093.923591146136, 5106.744662766847, 5115.87210319745, 5122.692638441631, 5124.948750512447, 5101.489851014869, 5104.004719079818, 5104.132297509433, 5104.923426148611, 5136.794528218904, 4059.06641472463, 4080.2451546464, 4086.5300490443383, 4138.979305103455, 4236.618704316565, 3792.355299599075, 3799.0, 3847.2305538891774, 3861.1119442527815, 3874.3994680824517, 4439.267520859086, 4452.688311818141, 4458.8439404620685, 4495.730256184639, 4511.932321015187, 4927.063857867065, 5091.974540127276, 5243.711595862188, 5249.711265880337, 5251.711155886463, 4385.912281754347, 4436.844710435119, 4446.155230506193, 4480.731156130642, 4485.708428952108, 4650.069986002813, 4650.581447669726, 4650.906981860344, 4691.859244222679, 4696.436427628706, 4726.503717109791, 4846.394200724839, 4847.975760121318, 4892.951070489392, 4898.53463920927, 5177.741112944263, 5194.194899790538, 5202.037623039599, 5247.370315562004, 5253.763580638957, 4834.540718631724, 4840.636952228527, 4866.075445665312, 4922.556969872729, 4922.901541969069, 4871.683340582851, 5025.47232540578, 5116.027954688598, 5123.923141152811, 5142.614303927146, 5124.718140502159, 5176.456472070529, 5188.118019936695, 5212.426633070435, 5220.843374698765, 5008.749562521933, 5010.749462526786, 5019.548240658358, 5022.67352622093, 5066.164082926276, 4765.285207218945, 4945.258211268195, 5004.39947206323, 5017.046761115376, 5017.874553136201, 4898.53463920927, 4988.0, 4997.100521906092, 4997.750112494434, 5003.199488081889, 5035.949640503694, 5046.949530504648, 5048.747562621781, 5049.368828896388, 5097.92353114711, 4798.880027999328, 4846.079244943449, 4848.296996935495, 4938.604911606991, 4950.084234416644], "value": 4733.208718293671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.9749361278742, 564.8644325361914, 568.6190252530804, 575.5136909311632, 575.9827205183843, 28383.858080709593, 38654.806725966366, 40101.59898401012, 40163.79918100413, 44520.0, 40076.59923400765, 40387.0, 40398.0, 40515.0, 40785.18429631413, 7282.380997615209, 7650.0, 7775.650095745705, 7800.804979875492, 7801.141874393812, 9696.903030969706, 9983.301168918179, 9995.750106247366, 10393.84409233862, 10398.636047738331, 10074.597016119347, 10176.694699159038, 10184.185265178805, 10184.847227291559, 10185.89814101857, 9951.253655975795, 9997.600095996151, 10017.298789084767, 10018.599256029715, 10024.749381265454, 9715.27135464843, 9772.560234789451, 9776.657816976443, 9786.363886347364, 9786.608535658565, 37858.0, 38015.809920950494, 38040.80979595112, 38067.23865522702, 38083.61916380828, 3064.264576501646, 3182.8567714452674, 3350.3299340131825, 3650.105724097613, 3723.6090210527777, 29752.8512357439, 29849.552256716168, 30179.0, 30559.0, 30672.846635766902, 3238.3199528098894, 3317.56871606692, 3326.3181047885128, 3388.2376465295356, 3466.185446420089, 242630.0, 243261.0, 243484.0, 243585.0, 244276.0, 31940.36119277648, 32944.83527582395, 32962.8351858244, 53182.0, 53538.732306339, 34159.65840341614, 34239.31521369558, 34324.31351372958, 34380.14049648779, 34384.484232736526, 13224.404901779442, 13430.328483575782, 13480.460781568823, 13489.527866524624, 13491.730165396637, 9993.80012399748, 10647.25469217163, 10769.730756731144, 10947.34315941046, 10999.725006874733, 8017.6792928283385, 8021.117677055519, 8051.51690898548, 8115.715949941724, 8120.796980075427, 3069.478188707925, 3089.258577941278, 3094.8607312670533, 3135.5766971459016, 3160.762942779301, 899.6851102114208, 905.2893478619252, 927.9931274567035, 963.8843338799248, 1029.897010298964, 27455.45089098247, 29287.560686589717, 29305.56041659377, 29376.773222041073, 29757.107286781433, 950.7290422229631, 961.0965692249403, 961.9951900240594, 1007.3603261928728, 1031.2368847053126, 15069.849301507064, 15174.24128793556, 15430.38278468871, 15664.530064098095, 15714.449994250146, 402010.0, 405892.0, 406232.0, 406585.0, 406661.0, 48978.26532602014, 49462.0, 49549.0, 49565.50434495681, 49605.751971239915, 1067.556963860005, 1181.078758568318, 1184.2065815903366, 1197.3474456421097, 1206.9155159138952, 28033.43933121367, 29129.7087029127, 29277.85361073181, 29370.265743356587, 29955.550666739582, 43014.56985430106, 43557.564424355354, 43560.564394356916, 43724.0, 43732.78133609312, 314305.0, 318009.0, 318170.0, 318284.0, 318488.0, 25337.493250135263, 25932.740672593787, 25941.22176334713, 27018.459630807665, 27133.74395072525, 42291.57708422876, 42436.78781606072, 42450.150996980505, 42540.36189457099, 42627.7868610655, 35528.822355888056, 36029.27941441209, 36222.4566631506, 36654.26691466209, 36659.45010824787, 35796.64203357933, 36377.636223637426, 36384.818075909454, 36553.268934621694, 36769.63230367662, 35521.82239088788, 35730.28539429249, 35744.0, 36850.07874803151, 39207.80396098115, 32251.35497290088, 34016.65983340234, 34443.655563444045, 34476.482852757734, 34476.655233447345, 24901.750982489943, 24971.75028249767, 25089.49821003606, 25164.112691548573, 25170.496590068462], "value": 16993.859575715767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.833655341874, 362.78776915504426, 368.0944875606009, 371.63579691901924, 385.6798856948733, 12944.676383090416, 16382.508524744262, 16529.66940661186, 17605.383811566597, 17734.201960911756, 16412.425565105194, 16505.0, 16867.662646747056, 17064.48806535806, 17074.402395916146, 4901.754912254391, 5011.574016208627, 5167.664101833388, 5179.300794392765, 5184.585233181337, 3725.2549490102087, 5082.161443361841, 5164.561012313958, 5687.516561092291, 6008.0, 6012.428819262163, 6044.063170208603, 6049.546284028694, 6050.2437195350585, 6052.818415447544, 5134.563562097245, 5381.650192737459, 5400.78396864125, 5475.863103422406, 6029.1257767623665, 5292.285541451932, 5310.36275646921, 5314.441983591744, 5318.946810531884, 5321.175217841241, 11991.16061875669, 12036.39818009096, 12249.387530623433, 12353.258804471761, 12377.443015064344, 1865.4776662534377, 1868.813118688134, 1921.2027008791335, 1931.1020375525447, 1932.3623204342673, 8621.0, 8945.59744811485, 9308.767280817967, 9518.95240523793, 9536.2371010319, 1707.4621494229277, 1736.079877664827, 1745.9388921387817, 1763.3034951194334, 1795.6532600549588, 45866.77066614679, 61719.38280617226, 65841.0, 76565.0, 78633.67514786684, 15159.545213643609, 16326.673466530603, 16602.916985414995, 16662.83337166613, 16774.39996800498, 30118.397632047236, 30132.698673013427, 30143.09570712882, 30148.698513015028, 30170.49147542614, 8342.791430214173, 8890.59992300348, 9011.684591039413, 9138.54307284633, 9149.268058555299, 7404.259574042552, 7601.163871974079, 7689.231076892378, 7724.729634462767, 8007.559584222807, 8450.408471406943, 8584.0, 8643.481391116553, 8662.91713535808, 8735.956320218485, 2674.8127631066027, 3208.5668434761474, 3332.250243695149, 3348.983255083709, 3381.03640462467, 811.6509900742619, 858.6264974735885, 896.587569717924, 899.6581299106298, 971.582219645545, 16513.504594862174, 17033.7444938326, 17705.468835934942, 17785.822141778415, 18070.18684159216, 845.5434065604504, 862.607513581319, 871.6034204436966, 881.9382643215042, 888.9911100889037, 9572.425654460616, 10077.395356278646, 10115.291929564859, 10120.696379108638, 10176.542055607515, 385651.0, 386977.0, 392489.0, 398555.0, 399189.0, 46179.5382046182, 46585.53414465812, 79938.0, 80622.19377806265, 81005.59497202476, 902.6885724425194, 921.1847514949184, 935.6538080910107, 935.6725146198912, 939.9342046056711, 15543.145127018122, 15673.451429199924, 16087.597810054374, 16307.429239976544, 16486.505404837873, 26956.865215673795, 37596.812015939744, 39180.2163956725, 39309.41035884407, 39482.2103557933, 52039.479605203465, 52278.47721522736, 52356.47643523516, 53502.1974670388, 53611.0, 7043.908194229903, 7155.606441645759, 7380.852382952418, 7434.553926764412, 7840.568768717775, 10894.400807955639, 10946.39794811293, 11100.444977751242, 11270.422140900117, 11324.207305488537, 9594.616215351587, 9695.321327507007, 9756.560954756911, 10033.648822291185, 10163.796724065625, 9449.0, 10123.0, 10233.130183934449, 10278.537465813906, 10343.431111288952, 9328.860067098864, 9574.329796914428, 9696.660616878658, 9879.851802223116, 10205.59177632916, 7296.671649775667, 7406.44451666138, 7500.512466689648, 7565.546067235983, 7767.339776118867, 8340.833183336421, 9471.47906865129, 9508.857367139637, 9748.951255243679, 10318.226133039901], "value": 8673.728099923552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.2450215628169, 1393.9963226476937, 1420.2259768426206, 1659.809121950976, 1676.044654546908, 7045.5772653640815, 7569.735059272926, 7575.659095340709, 7579.696812127509, 7597.962010189955, 6540.084388185658, 7130.073090498228, 7290.198078211406, 7356.485046046779, 7477.401807855372, 2080.4694802825256, 2106.1049054152, 2111.2927169398195, 2112.6197284488785, 2114.143771772435, 2068.4778711707786, 2099.496120930973, 2146.828253739705, 2149.9570008599817, 2154.3213887625425, 1838.209569884949, 2073.3779866040204, 2131.6482780341225, 2132.861364011342, 2142.817860481861, 2141.5716856628737, 2148.7851214878465, 2165.2746329979477, 2168.8915554222385, 2171.392010237136, 2075.138817390781, 2111.9049642766113, 2112.4718820294925, 2112.7675955645022, 2116.1323857218467, 7213.134423869169, 7275.4179665626625, 7277.053982982231, 7280.781576552712, 7281.162666293391, 4226.725262857904, 4357.673174511924, 4361.5856493633055, 4364.388985542027, 4372.781360931941, 2710.2953232159584, 2796.5245908195657, 2821.435712857416, 2832.6459192600923, 2849.5155823509845, 902.5442151713409, 937.9015203403612, 962.4225464721181, 963.6145541783272, 968.2060710217625, 9984.400935943793, 10001.549930253155, 10012.499375031219, 10012.849807252824, 10031.74920626983, 3849.1531862990096, 3960.7029472789654, 4087.713860029829, 4171.812268447927, 4177.078543869793, 8672.6530938763, 8682.262007729414, 8690.348223883235, 8710.912890871137, 8714.433561818461, 4388.670849686287, 4394.2969124939855, 4398.670099742532, 4399.604035636744, 4399.802008909607, 3924.4898163238595, 3946.6645335146836, 3951.604839516083, 3970.4441378207075, 3972.7616343019513, 3520.8767693130617, 3611.5485564304463, 3629.1108678373967, 3669.027707657473, 3669.412893936957, 1172.0857730969858, 1176.7646470705893, 1185.857697076339, 1202.6151631477844, 1202.8135638975973, 616.6454288783967, 738.1953670499182, 807.8182408958055, 841.6128580852876, 846.3187134356779, 5063.544281014726, 5192.636515443958, 5202.583793296527, 5254.2118682197215, 5432.158015507603, 790.6086487188878, 857.2927334948693, 858.7419430534297, 860.4450129666455, 887.5606574745542, 3788.6969042476535, 3882.650561449483, 3888.902777430587, 3936.527616685959, 3943.645071943539, 8983.416077955042, 9324.0, 9327.860082098774, 9336.673216437528, 9339.299552533586, 9241.861372079424, 9246.907530924605, 9279.350445468752, 9281.860772088425, 9290.860637090449, 6859.828504287433, 7083.0, 7087.149542054884, 7107.573545587178, 7107.644617769194, 5124.590032797441, 5362.222477740784, 5403.270558474555, 5430.83707488776, 5597.80407685729, 8579.871301930601, 8581.227689507974, 8610.095939926468, 8625.137486251324, 8677.566121694017, 8017.599120044091, 8349.791255218668, 8359.749207523784, 8576.828463430822, 8727.956360218159, 6373.521985850987, 6526.086347911391, 6545.770898018546, 6554.63949482783, 6555.672216389257, 6880.0711903894335, 6905.930940690529, 6920.653967301715, 6922.1001269836615, 6929.341712537301, 6425.807225783234, 6488.870222595428, 6492.220933488012, 6537.542372033912, 6669.299723529154, 6269.937300626935, 6407.135036769976, 6407.391297826885, 6433.035044743326, 6482.70827812759, 6060.181875446759, 6161.075838624242, 6165.537584681257, 6168.074788781719, 6173.475254603409, 4360.847370342023, 4366.694331396771, 4430.645548356059, 4544.545545445429, 4644.37300964379, 4421.513633500248, 4574.951492146429, 4587.587117159472, 4650.37219975299, 4667.766611669471], "value": 4017.252744282185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.420275246754, 289.51795260890617, 300.27633403497566, 301.03368188116144, 301.13724180223653, 4804.279358096287, 4831.4685384607665, 4834.444038935523, 4863.829765958192, 4887.584555312798, 4786.664933454659, 4800.447948485925, 4801.951980480194, 4814.7351895645725, 4824.215040435035, 3820.739156078487, 3839.731218814684, 3843.711721620876, 3850.152966347399, 3857.8263978121054, 3553.3426316131468, 3607.8376473058643, 3844.884653460401, 3853.614638536152, 3857.189990102082, 3149.7165255127034, 3648.8289467766635, 3652.853885844563, 3655.689266412358, 3775.7168212384045, 3615.963840361589, 3762.435634654796, 3765.3034188675047, 3777.301199278142, 3784.394496880486, 3340.832958352097, 3342.9331413371597, 3343.8996830095134, 3346.330733853215, 3350.4136776064092, 4483.170613436525, 4548.749818759967, 4630.268141796322, 4703.002447919275, 4732.692374995649, 4288.378185163165, 4290.442242508485, 4292.849750258726, 4313.986213239886, 4322.265214913472, 5024.572911302544, 5029.8934234468725, 5030.346055012825, 5035.54680078791, 5045.772940217699, 3542.256126213498, 3615.6745892869767, 3624.6439814120768, 3633.909152271188, 3653.4337177737493, 5226.817061402832, 5227.477252274742, 5228.241904923802, 5233.764480598382, 5242.7116508591635, 3718.330700473941, 3719.274741425396, 3730.477733117366, 3733.8693145739767, 3744.202782664336, 3696.2053158571034, 3763.6236376362144, 3789.2610940866816, 3791.962080379216, 3810.1998580297895, 4257.510386305615, 4266.829326826892, 4274.679399045084, 4283.550227226158, 4289.0, 4992.900141997213, 4996.525330093636, 5005.899882002413, 5006.824761133343, 5034.723090230073, 1283.775339315616, 1287.9162854414433, 1294.5469085819889, 1297.9091463597458, 1302.2707283921034, 904.674317245791, 917.3395155488038, 918.9632414703337, 923.1091996223677, 923.5382308845577, 4401.779911004501, 4410.933835992462, 4413.933790993137, 4435.711678740936, 4437.755923424178, 5132.3327967364, 5139.897202055938, 5153.948460515347, 5154.690718556899, 5161.503164082449, 4280.67894907877, 4401.757903315284, 4426.800793964279, 4438.223310920576, 4447.955520444819, 2410.81918856083, 2435.8173137014796, 2441.0357908626347, 2444.987775061113, 2448.6939132608422, 4250.404943307939, 4318.222719910446, 4318.978405108017, 4319.444999800069, 4618.65360097994, 4681.344611754357, 5168.095583272912, 5183.974080129575, 5204.0, 5206.973965130226, 4804.159272127434, 4833.419989601271, 4881.242098214498, 4895.583875370633, 4896.975515122402, 5132.409772876018, 5155.9742201288755, 5161.690298582097, 5165.328507294028, 5189.4032186299055, 4815.855524334275, 5046.57104146137, 5057.898842023213, 5082.644214904921, 5084.466131056334, 4867.756612169306, 4881.339669879853, 4909.3126962224605, 4912.1158191525865, 4930.654854160318, 3627.383344831332, 3627.927441451209, 3646.6717995380545, 3661.2860492203763, 3664.992127165051, 5086.660136337327, 5219.416388887525, 5221.660592061504, 5223.52988231061, 5243.895122097613, 5019.0, 5034.14419548685, 5037.4887533739, 5047.369078865142, 5051.520105589963, 5026.899462010812, 5037.722925239147, 5037.974810125926, 5047.167217409086, 5048.217526283432, 4762.9285560715925, 4962.0, 4974.427940786711, 4982.950170498249, 4984.17761069434, 5037.345145131109, 5060.114479965918, 5060.3927528696795, 5062.696238225718, 5070.5943524517215, 4893.877653058702, 4976.536614375907, 4976.8755781105765, 4986.626003049858, 4988.152014157529], "value": 3777.042320305668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.767356078251, 666.0209492046693, 677.6171463123331, 711.1182134153648, 731.5135434935767, 12116.212446191003, 13629.386677599507, 13648.795268070988, 13687.931560342196, 13710.24593647349, 13653.590392288223, 13728.931355343235, 13754.72490550191, 13803.171809691425, 13815.861841381584, 626.5363630913114, 761.1969372312209, 769.0886299734805, 787.9054513458393, 787.9409044321699, 781.03932163439, 787.3032366355787, 787.401574803148, 791.3945831438954, 792.0258082558456, 834.1158372125536, 835.3484282259847, 835.5613303015934, 836.0302049622439, 836.2139588786521, 658.2200092889941, 806.6491076381793, 831.8128421105264, 831.8793774902636, 832.2800777327568, 601.9006863867501, 603.0200923499314, 603.0532064658488, 604.2054698072021, 604.7339170764849, 13083.084184107116, 13083.280419576919, 13095.410706518229, 13098.803517947143, 13100.410481528354, 13514.189148651112, 13622.18266903979, 14013.159210447304, 14040.157590544497, 14356.712865742627, 10488.265821392506, 10668.893311066868, 10693.518791654395, 10999.23005389623, 11096.889031109748, 3292.9176770580925, 3294.6540613235506, 3299.4555898276753, 3323.135984643986, 3384.1539615096226, 64465.0, 65349.34650653528, 66606.0, 67358.66320668414, 68163.0, 10947.288426252268, 10957.17821163416, 10962.671119866416, 11114.11087113029, 11335.03652189573, 20956.266530671353, 21072.789272107388, 21176.682349764767, 21214.681779773317, 21438.0, 7012.719491220294, 7031.542949708252, 7040.155181378165, 7263.418926485974, 7444.813879652944, 3755.7183211259266, 3802.068493219179, 3834.884953451401, 3889.78606176663, 3902.804859757001, 2920.8685609147637, 3022.7732920031085, 3041.6045914031033, 3050.847457627154, 3056.847157642109, 478.3972195034282, 479.5827629961886, 483.16894940701934, 491.2753688309786, 498.30486471372234, 572.4876235769046, 608.8964875971006, 621.8456656170727, 628.2680677011322, 633.0630666613438, 8039.437239393186, 8199.180081991872, 8213.589320533949, 8306.750797475965, 8399.28606068491, 512.5617596954625, 576.6972339521784, 591.9940800592025, 598.9550783691241, 601.5969300568629, 4026.5168179818024, 4177.3316269397355, 4231.344141658048, 4327.610515053598, 4451.5103338632725, 95183.0, 101381.49309253406, 102076.0, 104385.0, 104790.47604761928, 51140.0, 51459.0, 78547.21452785513, 89342.55328723315, 91949.54025229964, 45361.0, 45787.31319030217, 75138.62430687812, 76159.61920190364, 76853.6157319221, 7269.454790890599, 7730.7680769577, 7929.563873986986, 8125.187481251827, 8194.385421093322, 32552.83723581367, 37099.17710697592, 42328.0, 43447.565524344354, 46251.21859767529, 58920.41079589149, 63816.68091659512, 64594.67702661457, 64631.0, 65014.0, 10043.347182433119, 10125.443100629242, 10495.947520262349, 10962.287451315638, 11745.941270293593, 12402.441890114786, 13319.66700832487, 13562.728745425233, 13679.247641379421, 14233.430662773373, 11809.645710628694, 12071.326506310916, 12198.390080495763, 12379.93810030944, 12599.370031498573, 12114.636560903187, 12225.37559291063, 12425.502979880703, 12553.058520611174, 12647.747045058863, 12531.373431328579, 12778.169418987736, 12841.0, 13060.346982651019, 13169.670758230737, 10155.7461063474, 10585.788284234119, 10715.142788577052, 10716.517756701123, 11109.722256943642, 8625.568721564023, 9921.305508614329, 10589.417582033062, 10686.83969740439, 10707.625233116803], "value": 6653.701579413722, "unit": "score"}], "name": "dromaeo_css", "value": 6426.502451766016, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 112.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 124.0, 184.0, 123.0, 125.0, 153.0, 121.0, 165.0, 122.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 159.0, 161.0, 164.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 123.0, 75.0, 76.0, 75.0, 77.0, 104.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 128.0, 86.0, 86.0, 87.0, 117.0, 85.0, 86.0, 130.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 94.0, 95.0, 94.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 69.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 76.0, 65.0, 66.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 89.0, 83.0, 81.0, 79.0, 79.0, 78.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 140.0, 138.0, 131.0, 139.0, 133.0, 137.0, 167.0, 134.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 164.0, 173.0, 175.0, 167.0, 165.0, 168.0, 167.0, 165.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 69.0, 70.0, 67.0, 67.0, 67.0, 66.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1540.8, "alertThreshold": 2.0}]} 10:55:03 INFO - Return code: 0 10:55:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:03 INFO - # TBPL SUCCESS # 10:55:03 INFO - Running post-action listener: _resource_record_post_action 10:55:03 INFO - [mozharness: 2016-08-03 17:55:03.869886Z] Finished run-tests step (success) 10:55:03 INFO - Running post-run listener: _resource_record_post_run 10:55:03 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 526323712; Read time: 108; Write time: 498304 10:55:03 INFO - TinderboxPrint: CPU usage
13.0% 10:55:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 108 10:55:03 INFO - TinderboxPrint: I/O write bytes / time
526,323,712 / 498,304 10:55:03 INFO - TinderboxPrint: CPU idle
8,347.5 (87.0%) 10:55:03 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 10:55:03 INFO - TinderboxPrint: Swap in / out
0 / 0 10:55:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237133824; Read time: 0; Write time: 287560 10:55:03 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284692480; Read time: 92; Write time: 210244 10:55:04 INFO - Running post-run listener: _upload_blobber_files 10:55:04 INFO - Blob upload gear active. 10:55:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:55:04 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:55:04 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:55:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:08 INFO - (blobuploader) - INFO - Done attempting. 10:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:09 INFO - (blobuploader) - INFO - Done attempting. 10:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:10 INFO - (blobuploader) - INFO - Done attempting. 10:55:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:10 INFO - Return code: 0 10:55:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/01c36fdf240fcb311808ea84550ade007d01e95fce5392071c052502c0e58e50da1e36ef6671f425efeefbae72c4816c09751bee212db9f6047d95ea03ebf287", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4d204e12229db4b52b52f856c300a4704febf48d297986165b76fc62979ede74e0f68cef29844d99971cb3aba6414b0398e9e860a152fa91f337953d41363f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d4ab23edf059aceff866afa7b9bb0868832c8dbd9fbee2581bf80878828ad62363d1865e1308d349ab1d459318d572e72828ebee759dd6bde98331ef61fa16c"} 10:55:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:10 INFO - Contents: 10:55:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/01c36fdf240fcb311808ea84550ade007d01e95fce5392071c052502c0e58e50da1e36ef6671f425efeefbae72c4816c09751bee212db9f6047d95ea03ebf287", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4d204e12229db4b52b52f856c300a4704febf48d297986165b76fc62979ede74e0f68cef29844d99971cb3aba6414b0398e9e860a152fa91f337953d41363f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d4ab23edf059aceff866afa7b9bb0868832c8dbd9fbee2581bf80878828ad62363d1865e1308d349ab1d459318d572e72828ebee759dd6bde98331ef61fa16c"} 10:55:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:10 INFO - Copying logs to upload dir... 10:55:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.688106 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 10:55:10.042347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 10:55:10.045672) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/01c36fdf240fcb311808ea84550ade007d01e95fce5392071c052502c0e58e50da1e36ef6671f425efeefbae72c4816c09751bee212db9f6047d95ea03ebf287", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4d204e12229db4b52b52f856c300a4704febf48d297986165b76fc62979ede74e0f68cef29844d99971cb3aba6414b0398e9e860a152fa91f337953d41363f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d4ab23edf059aceff866afa7b9bb0868832c8dbd9fbee2581bf80878828ad62363d1865e1308d349ab1d459318d572e72828ebee759dd6bde98331ef61fa16c"} build_url:https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/LEvY1CTcQ4mi_DGkuc9KDg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/01c36fdf240fcb311808ea84550ade007d01e95fce5392071c052502c0e58e50da1e36ef6671f425efeefbae72c4816c09751bee212db9f6047d95ea03ebf287", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4d204e12229db4b52b52f856c300a4704febf48d297986165b76fc62979ede74e0f68cef29844d99971cb3aba6414b0398e9e860a152fa91f337953d41363f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d4ab23edf059aceff866afa7b9bb0868832c8dbd9fbee2581bf80878828ad62363d1865e1308d349ab1d459318d572e72828ebee759dd6bde98331ef61fa16c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 10:55:10.074494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:55:10.074880) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470245668.278641-704830682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 10:55:10.157981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 10:55:10.158675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 10:55:10.159218) ========= ========= Total master_lag: 0.17 =========