builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1470178380.63 results: success (0) buildid: 20160802153150 builduid: c7d0b294c96d4710a6686f07d3b4e224 revision: 7ab959c316fca2fc209431491644af62bb93dbdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.635319) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.635743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.636020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.673670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.674014) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 15:53:00-- 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% 88.2M=0s 2016-08-02 15:53:01 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.773157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.773482) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016635 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.830719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:00.831112) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7ab959c316fca2fc209431491644af62bb93dbdc --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 7ab959c316fca2fc209431491644af62bb93dbdc --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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 15:53:01,157 truncating revision to first 12 chars 2016-08-02 15:53:01,157 Setting DEBUG logging. 2016-08-02 15:53:01,157 attempt 1/10 2016-08-02 15:53:01,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7ab959c316fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 15:53:01,497 unpacking tar archive at: autoland-7ab959c316fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:01.524153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:01.524498) ========= script_repo_revision: 7ab959c316fca2fc209431491644af62bb93dbdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:01.524911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:01.525196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 15:53:01.535741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-02 15:53:01.536152) ========= /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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:01 INFO - MultiFileLogger online at 20160802 15:53:01 in /builds/slave/test 15:53:01 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 15:53:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:01 INFO - {'append_to_log': False, 15:53:01 INFO - 'base_work_dir': '/builds/slave/test', 15:53:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:53:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:01 INFO - 'branch': 'Autoland-Non-PGO', 15:53:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:01 INFO - 'config_files': ('talos/linux_config.py',), 15:53:01 INFO - 'default_actions': ('clobber', 15:53:01 INFO - 'read-buildbot-config', 15:53:01 INFO - 'download-and-extract', 15:53:01 INFO - 'populate-webroot', 15:53:01 INFO - 'create-virtualenv', 15:53:01 INFO - 'install', 15:53:01 INFO - 'run-tests'), 15:53:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:01 INFO - 'download_minidump_stackwalk': True, 15:53:01 INFO - 'download_symbols': 'ondemand', 15:53:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:01 INFO - 'installer_path': 'installer.exe', 15:53:01 INFO - 'log_level': 'info', 15:53:01 INFO - 'log_name': 'talos', 15:53:01 INFO - 'log_to_console': True, 15:53:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:01 INFO - 'opt_config_files': (), 15:53:01 INFO - 'pip_index': False, 15:53:01 INFO - 'sps_profile': False, 15:53:01 INFO - 'sps_profile_interval': 0, 15:53:01 INFO - 'suite': 'dromaeojs', 15:53:01 INFO - 'system_bits': '32', 15:53:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:01 INFO - 'title': 'talos-linux64-ix-055', 15:53:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:01 INFO - 'use_talos_json': True, 15:53:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:01 INFO - 'work_dir': 'build'} 15:53:01 INFO - [mozharness: 2016-08-02 22:53:01.949842Z] Running clobber step. 15:53:01 INFO - Running pre-action listener: _resource_record_pre_action 15:53:01 INFO - Running main action method: clobber 15:53:01 INFO - rmtree: /builds/slave/test/build 15:53:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:02 INFO - Running post-action listener: _resource_record_post_action 15:53:02 INFO - [mozharness: 2016-08-02 22:53:02.409893Z] Finished clobber step (success) 15:53:02 INFO - [mozharness: 2016-08-02 22:53:02.409995Z] Running read-buildbot-config step. 15:53:02 INFO - Running pre-action listener: _resource_record_pre_action 15:53:02 INFO - Running main action method: read_buildbot_config 15:53:02 INFO - Using buildbot properties: 15:53:02 INFO - { 15:53:02 INFO - "project": "", 15:53:02 INFO - "product": "firefox", 15:53:02 INFO - "script_repo_revision": "production", 15:53:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:53:02 INFO - "repository": "", 15:53:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:53:02 INFO - "buildid": "20160802153150", 15:53:02 INFO - "pgo_build": "False", 15:53:02 INFO - "basedir": "/builds/slave/test", 15:53:02 INFO - "buildnumber": 129, 15:53:02 INFO - "slavename": "talos-linux64-ix-055", 15:53:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:53:02 INFO - "platform": "ubuntu64_hw", 15:53:02 INFO - "scheduler": "tests-autoland-linux64-talos", 15:53:02 INFO - "branch": "autoland", 15:53:02 INFO - "repo_path": "integration/autoland", 15:53:02 INFO - "revision": "7ab959c316fca2fc209431491644af62bb93dbdc", 15:53:02 INFO - "stage_platform": "linux64", 15:53:02 INFO - "builduid": "c7d0b294c96d4710a6686f07d3b4e224", 15:53:02 INFO - "slavebuilddir": "test" 15:53:02 INFO - } 15:53:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:53:02 INFO - Running post-action listener: _resource_record_post_action 15:53:02 INFO - [mozharness: 2016-08-02 22:53:02.412426Z] Finished read-buildbot-config step (success) 15:53:02 INFO - [mozharness: 2016-08-02 22:53:02.412513Z] Running download-and-extract step. 15:53:02 INFO - Running pre-action listener: _resource_record_pre_action 15:53:02 INFO - Running main action method: download_and_extract 15:53:02 INFO - mkdir: /builds/slave/test/build/tests 15:53:02 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')]} 15:53:02 INFO - https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:04 INFO - Downloaded 1361 bytes. 15:53:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:53:04 INFO - Using the following test package requirements: 15:53:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:53:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'jsshell-linux-x86_64.zip'], 15:53:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:53:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:53:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:04 INFO - https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:04 INFO - Downloaded 20239561 bytes. 15:53:04 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'] 15:53:04 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 15:53:06 INFO - Return code: 0 15:53:06 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 15:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:06 INFO - https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:14 INFO - Downloaded 20239561 bytes. 15:53:14 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'] 15:53:14 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 15:53:15 INFO - Return code: 0 15:53:15 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')]} 15:53:15 INFO - https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:16 INFO - Downloaded 14413723 bytes. 15:53:16 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'] 15:53:16 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 15:53:16 INFO - Return code: 0 15:53:16 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')]} 15:53:16 INFO - https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dew9K8wmRFOjkAPggDmRXw/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 15:53:17 INFO - Downloaded 55632568 bytes. 15:53:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:53:17 INFO - mkdir: /builds/slave/test/properties 15:53:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:17 INFO - Contents: 15:53:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:53:18 INFO - Running post-action listener: _resource_record_post_action 15:53:18 INFO - Running post-action listener: set_extra_try_arguments 15:53:18 INFO - [mozharness: 2016-08-02 22:53:18.455830Z] Finished download-and-extract step (success) 15:53:18 INFO - [mozharness: 2016-08-02 22:53:18.456063Z] Running populate-webroot step. 15:53:18 INFO - Running pre-action listener: _resource_record_pre_action 15:53:18 INFO - Running main action method: populate_webroot 15:53:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:18 INFO - '--tppagecycles', 15:53:18 INFO - '7'], 15:53:18 INFO - 'tests': ['tsvgm']}}, 15:53:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['damp', 'tps']}, 15:53:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'tests': ['damp', 'tps']}, 15:53:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['dromaeo_dom']}, 15:53:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['basic_compositor_video']}, 15:53:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['a11yr', 15:53:18 INFO - 'ts_paint', 15:53:18 INFO - 'tpaint', 15:53:18 INFO - 'sessionrestore', 15:53:18 INFO - 'sessionrestore_no_auto_restore', 15:53:18 INFO - 'tabpaint']}, 15:53:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['tsvgx', 15:53:18 INFO - 'tsvgr_opacity', 15:53:18 INFO - 'tart', 15:53:18 INFO - 'tscrollx', 15:53:18 INFO - 'cart']}, 15:53:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:18 INFO - 'tsvgr_opacity', 15:53:18 INFO - 'tart', 15:53:18 INFO - 'tscrollx', 15:53:18 INFO - 'cart']}, 15:53:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'talos_options': ['--disable-e10s'], 15:53:18 INFO - 'tests': ['tp5o']}, 15:53:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'tests': ['tp5o']}, 15:53:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'talos_options': ['--disable-e10s', 15:53:18 INFO - '--xperf_path', 15:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:18 INFO - 'tests': ['tp5n']}, 15:53:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:18 INFO - 'talos_options': ['--xperf_path', 15:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:18 INFO - 'tests': ['tp5n']}}, 15:53:18 INFO - 'talos.zip': {'path': '', 15:53:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:18 INFO - Running post-action listener: _resource_record_post_action 15:53:18 INFO - [mozharness: 2016-08-02 22:53:18.477512Z] Finished populate-webroot step (success) 15:53:18 INFO - [mozharness: 2016-08-02 22:53:18.477600Z] Running create-virtualenv step. 15:53:18 INFO - Running pre-action listener: _resource_record_pre_action 15:53:18 INFO - Running main action method: create_virtualenv 15:53:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:18 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 15:53:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:18 INFO - Using real prefix '/usr' 15:53:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:19 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:21 INFO - Installing pip.................done. 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:21 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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'DISPLAY': ':0', 15:53:21 INFO - 'HOME': '/home/cltbld', 15:53:21 INFO - 'LANG': 'en_US.UTF-8', 15:53:21 INFO - 'LANGUAGE': 'en_US:en', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MAIL': '/var/mail/cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SHLVL': '1', 15:53:21 INFO - 'TERM': 'linux', 15:53:21 INFO - 'TMOUT': '86400', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - '_': '/tools/buildbot/bin/python'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 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 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:21 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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'DISPLAY': ':0', 15:53:21 INFO - 'HOME': '/home/cltbld', 15:53:21 INFO - 'LANG': 'en_US.UTF-8', 15:53:21 INFO - 'LANGUAGE': 'en_US:en', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MAIL': '/var/mail/cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SHLVL': '1', 15:53:21 INFO - 'TERM': 'linux', 15:53:21 INFO - 'TMOUT': '86400', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - '_': '/tools/buildbot/bin/python'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 INFO - Downloading/unpacking psutil>=3.1.1 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:23 INFO - Installing collected packages: psutil 15:53:23 INFO - Running setup.py install for psutil 15:53:23 INFO - building 'psutil._psutil_linux' extension 15:53:23 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 15:53:23 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 15:53:23 INFO - building 'psutil._psutil_posix' extension 15:53:23 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 15:53:23 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 15:53:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:24 INFO - Successfully installed psutil 15:53:24 INFO - Cleaning up... 15:53:24 INFO - Return code: 0 15:53:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:24 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:24 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 15:53:24 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 15:53:24 INFO - Using env: {'DISPLAY': ':0', 15:53:24 INFO - 'HOME': '/home/cltbld', 15:53:24 INFO - 'LANG': 'en_US.UTF-8', 15:53:24 INFO - 'LANGUAGE': 'en_US:en', 15:53:24 INFO - 'LOGNAME': 'cltbld', 15:53:24 INFO - 'MAIL': '/var/mail/cltbld', 15:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:24 INFO - 'MOZ_NO_REMOTE': '1', 15:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:24 INFO - 'NO_EM_RESTART': '1', 15:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:24 INFO - 'PWD': '/builds/slave/test', 15:53:24 INFO - 'SHELL': '/bin/bash', 15:53:24 INFO - 'SHLVL': '1', 15:53:24 INFO - 'TERM': 'linux', 15:53:24 INFO - 'TMOUT': '86400', 15:53:24 INFO - 'USER': 'cltbld', 15:53:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:24 INFO - '_': '/tools/buildbot/bin/python'} 15:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:26 INFO - Installing collected packages: mozsystemmonitor 15:53:26 INFO - Running setup.py install for mozsystemmonitor 15:53:26 INFO - Successfully installed mozsystemmonitor 15:53:26 INFO - Cleaning up... 15:53:26 INFO - Return code: 0 15:53:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:26 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')]} 15:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 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')]} 15:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:26 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 15:53:26 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 15:53:26 INFO - Using env: {'DISPLAY': ':0', 15:53:26 INFO - 'HOME': '/home/cltbld', 15:53:26 INFO - 'LANG': 'en_US.UTF-8', 15:53:26 INFO - 'LANGUAGE': 'en_US:en', 15:53:26 INFO - 'LOGNAME': 'cltbld', 15:53:26 INFO - 'MAIL': '/var/mail/cltbld', 15:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:26 INFO - 'MOZ_NO_REMOTE': '1', 15:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:26 INFO - 'NO_EM_RESTART': '1', 15:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:26 INFO - 'PWD': '/builds/slave/test', 15:53:26 INFO - 'SHELL': '/bin/bash', 15:53:26 INFO - 'SHLVL': '1', 15:53:26 INFO - 'TERM': 'linux', 15:53:26 INFO - 'TMOUT': '86400', 15:53:26 INFO - 'USER': 'cltbld', 15:53:26 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:26 INFO - '_': '/tools/buildbot/bin/python'} 15:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:26 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 15:53:26 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 15:53:26 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 15:53:26 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 15:53:26 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 15:53:26 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 15:53:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:28 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 15:53:28 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 15:53:28 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 15:53:28 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 15:53:28 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 15:53:28 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 15:53:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:28 INFO - warning: no files found matching '*.txt' 15:53:28 INFO - no previously-included directories found matching 'build' 15:53:28 INFO - no previously-included directories found matching 'dist' 15:53:28 INFO - no previously-included directories found matching '.git*' 15:53:28 INFO - Installing collected packages: jsonschema, functools32 15:53:28 INFO - Running setup.py install for functools32 15:53:28 INFO - warning: no files found matching '*.txt' 15:53:28 INFO - no previously-included directories found matching 'build' 15:53:28 INFO - no previously-included directories found matching 'dist' 15:53:28 INFO - no previously-included directories found matching '.git*' 15:53:28 INFO - Successfully installed jsonschema functools32 15:53:28 INFO - Cleaning up... 15:53:28 INFO - Return code: 0 15:53:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:28 INFO - Using env: {'DISPLAY': ':0', 15:53:28 INFO - 'HOME': '/home/cltbld', 15:53:28 INFO - 'LANG': 'en_US.UTF-8', 15:53:28 INFO - 'LANGUAGE': 'en_US:en', 15:53:28 INFO - 'LOGNAME': 'cltbld', 15:53:28 INFO - 'MAIL': '/var/mail/cltbld', 15:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:28 INFO - 'MOZ_NO_REMOTE': '1', 15:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:28 INFO - 'NO_EM_RESTART': '1', 15:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:28 INFO - 'PWD': '/builds/slave/test', 15:53:28 INFO - 'SHELL': '/bin/bash', 15:53:28 INFO - 'SHLVL': '1', 15:53:28 INFO - 'TERM': 'linux', 15:53:28 INFO - 'TMOUT': '86400', 15:53:28 INFO - 'USER': 'cltbld', 15:53:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:28 INFO - '_': '/tools/buildbot/bin/python'} 15:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:29 INFO - Cleaning up... 15:53:29 INFO - Return code: 0 15:53:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:29 INFO - Using env: {'DISPLAY': ':0', 15:53:29 INFO - 'HOME': '/home/cltbld', 15:53:29 INFO - 'LANG': 'en_US.UTF-8', 15:53:29 INFO - 'LANGUAGE': 'en_US:en', 15:53:29 INFO - 'LOGNAME': 'cltbld', 15:53:29 INFO - 'MAIL': '/var/mail/cltbld', 15:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:29 INFO - 'MOZ_NO_REMOTE': '1', 15:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:29 INFO - 'NO_EM_RESTART': '1', 15:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:29 INFO - 'PWD': '/builds/slave/test', 15:53:29 INFO - 'SHELL': '/bin/bash', 15:53:29 INFO - 'SHLVL': '1', 15:53:29 INFO - 'TERM': 'linux', 15:53:29 INFO - 'TMOUT': '86400', 15:53:29 INFO - 'USER': 'cltbld', 15:53:29 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:29 INFO - '_': '/tools/buildbot/bin/python'} 15:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:29 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 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 15:53:31 INFO - Downloading docopt-0.6.1.tar.gz 15:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:32 INFO - Running setup.py install for blobuploader 15:53:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:32 INFO - Running setup.py install for requests 15:53:32 INFO - Running setup.py install for docopt 15:53:32 INFO - Successfully installed blobuploader requests docopt 15:53:32 INFO - Cleaning up... 15:53:32 INFO - Return code: 0 15:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:32 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:32 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 15:53:32 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 15:53:32 INFO - Using env: {'DISPLAY': ':0', 15:53:32 INFO - 'HOME': '/home/cltbld', 15:53:32 INFO - 'LANG': 'en_US.UTF-8', 15:53:32 INFO - 'LANGUAGE': 'en_US:en', 15:53:32 INFO - 'LOGNAME': 'cltbld', 15:53:32 INFO - 'MAIL': '/var/mail/cltbld', 15:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:32 INFO - 'MOZ_NO_REMOTE': '1', 15:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:32 INFO - 'NO_EM_RESTART': '1', 15:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:32 INFO - 'PWD': '/builds/slave/test', 15:53:32 INFO - 'SHELL': '/bin/bash', 15:53:32 INFO - 'SHLVL': '1', 15:53:32 INFO - 'TERM': 'linux', 15:53:32 INFO - 'TMOUT': '86400', 15:53:32 INFO - 'USER': 'cltbld', 15:53:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:32 INFO - '_': '/tools/buildbot/bin/python'} 15:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:32 INFO - Running setup.py (path:/tmp/pip-cBMlrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:32 INFO - Running setup.py (path:/tmp/pip-mAuBJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:33 INFO - Running setup.py (path:/tmp/pip-davc_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:33 INFO - Running setup.py (path:/tmp/pip-jufgKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:33 INFO - Running setup.py (path:/tmp/pip-OUyLjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:33 INFO - Running setup.py (path:/tmp/pip-S9MA8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:33 INFO - Running setup.py (path:/tmp/pip-ripy13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:33 INFO - Running setup.py (path:/tmp/pip-3ExVie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:33 INFO - Running setup.py (path:/tmp/pip-yOC2Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:33 INFO - Running setup.py (path:/tmp/pip-0ayipU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:33 INFO - Running setup.py (path:/tmp/pip-pPIwyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:33 INFO - Running setup.py (path:/tmp/pip-skQtt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:33 INFO - Running setup.py (path:/tmp/pip-PQYzX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:33 INFO - Running setup.py (path:/tmp/pip-uZ29wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:33 INFO - Running setup.py (path:/tmp/pip-v6YYzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:34 INFO - Running setup.py (path:/tmp/pip-iq3zFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:34 INFO - Running setup.py (path:/tmp/pip-um_7JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:34 INFO - Running setup.py install for manifestparser 15:53:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Running setup.py install for mozcrash 15:53:34 INFO - Running setup.py install for mozdebug 15:53:34 INFO - Running setup.py install for mozdevice 15:53:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Running setup.py install for mozfile 15:53:34 INFO - Running setup.py install for mozhttpd 15:53:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Running setup.py install for mozinfo 15:53:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Running setup.py install for mozInstall 15:53:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:34 INFO - Running setup.py install for mozleak 15:53:35 INFO - Running setup.py install for mozlog 15:53:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Running setup.py install for moznetwork 15:53:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Running setup.py install for mozprocess 15:53:35 INFO - Running setup.py install for mozprofile 15:53:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Running setup.py install for mozrunner 15:53:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Running setup.py install for mozscreenshot 15:53:35 INFO - Running setup.py install for moztest 15:53:35 INFO - Running setup.py install for mozversion 15:53:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:35 INFO - Cleaning up... 15:53:35 INFO - Return code: 0 15:53:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:35 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')]} 15:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:35 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')]} 15:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:35 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:35 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 15:53:35 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 15:53:35 INFO - Using env: {'DISPLAY': ':0', 15:53:35 INFO - 'HOME': '/home/cltbld', 15:53:35 INFO - 'LANG': 'en_US.UTF-8', 15:53:35 INFO - 'LANGUAGE': 'en_US:en', 15:53:35 INFO - 'LOGNAME': 'cltbld', 15:53:35 INFO - 'MAIL': '/var/mail/cltbld', 15:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:35 INFO - 'MOZ_NO_REMOTE': '1', 15:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:35 INFO - 'NO_EM_RESTART': '1', 15:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:35 INFO - 'PWD': '/builds/slave/test', 15:53:35 INFO - 'SHELL': '/bin/bash', 15:53:35 INFO - 'SHLVL': '1', 15:53:35 INFO - 'TERM': 'linux', 15:53:35 INFO - 'TMOUT': '86400', 15:53:35 INFO - 'USER': 'cltbld', 15:53:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:35 INFO - '_': '/tools/buildbot/bin/python'} 15:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:36 INFO - Running setup.py (path:/tmp/pip-cgnXgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:36 INFO - Running setup.py (path:/tmp/pip-OtMmmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:36 INFO - Running setup.py (path:/tmp/pip-JpvQ7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:36 INFO - Running setup.py (path:/tmp/pip-ZBN4Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:36 INFO - Running setup.py (path:/tmp/pip-0hdrzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:36 INFO - Running setup.py (path:/tmp/pip-xpwQht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:36 INFO - Running setup.py (path:/tmp/pip-uNTuES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:36 INFO - Running setup.py (path:/tmp/pip-gAVgkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:36 INFO - Running setup.py (path:/tmp/pip-PXhbCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:36 INFO - Running setup.py (path:/tmp/pip-CJSk6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:36 INFO - Running setup.py (path:/tmp/pip-eiPbxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:36 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)) 15:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:36 INFO - Running setup.py (path:/tmp/pip-JITzrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:37 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)) 15:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:37 INFO - Running setup.py (path:/tmp/pip-CF15LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:37 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)) 15:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:37 INFO - Running setup.py (path:/tmp/pip-6yTFwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:37 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)) 15:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:37 INFO - Running setup.py (path:/tmp/pip-CSg4ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:37 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)) 15:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:37 INFO - Running setup.py (path:/tmp/pip-z2aLYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:37 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)) 15:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:37 INFO - Running setup.py (path:/tmp/pip-TGzQD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:39 INFO - Downloading blessings-1.6.tar.gz 15:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:39 INFO - Installing collected packages: blessings 15:53:39 INFO - Running setup.py install for blessings 15:53:39 INFO - Successfully installed blessings 15:53:39 INFO - Cleaning up... 15:53:39 INFO - Return code: 0 15:53:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:39 INFO - Reading from file tmpfile_stdout 15:53:39 INFO - Current package versions: 15:53:39 INFO - argparse == 1.2.1 15:53:39 INFO - blessings == 1.6 15:53:39 INFO - blobuploader == 1.2.4 15:53:39 INFO - docopt == 0.6.1 15:53:39 INFO - functools32 == 3.2.3-2 15:53:39 INFO - jsonschema == 2.5.1 15:53:39 INFO - manifestparser == 1.1 15:53:39 INFO - mozInstall == 1.12 15:53:39 INFO - mozcrash == 0.17 15:53:39 INFO - mozdebug == 0.1 15:53:39 INFO - mozdevice == 0.48 15:53:39 INFO - mozfile == 1.2 15:53:39 INFO - mozhttpd == 0.7 15:53:39 INFO - mozinfo == 0.9 15:53:39 INFO - mozleak == 0.1 15:53:39 INFO - mozlog == 3.3 15:53:39 INFO - moznetwork == 0.27 15:53:39 INFO - mozprocess == 0.23 15:53:39 INFO - mozprofile == 0.28 15:53:39 INFO - mozrunner == 6.12 15:53:39 INFO - mozscreenshot == 0.1 15:53:39 INFO - mozsystemmonitor == 0.3 15:53:39 INFO - moztest == 0.7 15:53:39 INFO - mozversion == 1.4 15:53:39 INFO - psutil == 3.1.1 15:53:39 INFO - requests == 1.2.3 15:53:39 INFO - wsgiref == 0.1.2 15:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 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 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:39 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 15:53:39 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 15:53:39 INFO - Using env: {'DISPLAY': ':0', 15:53:39 INFO - 'HOME': '/home/cltbld', 15:53:39 INFO - 'LANG': 'en_US.UTF-8', 15:53:39 INFO - 'LANGUAGE': 'en_US:en', 15:53:39 INFO - 'LOGNAME': 'cltbld', 15:53:39 INFO - 'MAIL': '/var/mail/cltbld', 15:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:39 INFO - 'MOZ_NO_REMOTE': '1', 15:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:39 INFO - 'NO_EM_RESTART': '1', 15:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:39 INFO - 'PWD': '/builds/slave/test', 15:53:39 INFO - 'SHELL': '/bin/bash', 15:53:39 INFO - 'SHLVL': '1', 15:53:39 INFO - 'TERM': 'linux', 15:53:39 INFO - 'TMOUT': '86400', 15:53:39 INFO - 'USER': 'cltbld', 15:53:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:39 INFO - '_': '/tools/buildbot/bin/python'} 15:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 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)) 15:53:39 INFO - Cleaning up... 15:53:39 INFO - Return code: 0 15:53:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1259030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', '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 15:53:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:39 INFO - Using env: {'DISPLAY': ':0', 15:53:39 INFO - 'HOME': '/home/cltbld', 15:53:39 INFO - 'LANG': 'en_US.UTF-8', 15:53:39 INFO - 'LANGUAGE': 'en_US:en', 15:53:39 INFO - 'LOGNAME': 'cltbld', 15:53:39 INFO - 'MAIL': '/var/mail/cltbld', 15:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:39 INFO - 'MOZ_NO_REMOTE': '1', 15:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:39 INFO - 'NO_EM_RESTART': '1', 15:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:39 INFO - 'PWD': '/builds/slave/test', 15:53:39 INFO - 'SHELL': '/bin/bash', 15:53:39 INFO - 'SHLVL': '1', 15:53:39 INFO - 'TERM': 'linux', 15:53:39 INFO - 'TMOUT': '86400', 15:53:39 INFO - 'USER': 'cltbld', 15:53:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:39 INFO - '_': '/tools/buildbot/bin/python'} 15:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:40 INFO - Cleaning up... 15:53:40 INFO - Return code: 0 15:53:40 INFO - Running post-action listener: _resource_record_post_action 15:53:40 INFO - Running post-action listener: _start_resource_monitoring 15:53:40 INFO - Starting resource monitoring. 15:53:40 INFO - [mozharness: 2016-08-02 22:53:40.206869Z] Finished create-virtualenv step (success) 15:53:40 INFO - [mozharness: 2016-08-02 22:53:40.207338Z] Running install step. 15:53:40 INFO - Running pre-action listener: _resource_record_pre_action 15:53:40 INFO - Running main action method: install 15:53:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:40 INFO - Reading from file tmpfile_stdout 15:53:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:40 INFO - Reading from file tmpfile_stdout 15:53:40 INFO - Output received: 15:53:40 INFO - Usage: mozinstall [options] installer 15:53:40 INFO - Options: 15:53:40 INFO - -h, --help show this help message and exit 15:53:40 INFO - -d DEST, --destination=DEST 15:53:40 INFO - Directory to install application into. [default: 15:53:40 INFO - "/builds/slave/test"] 15:53:40 INFO - --app=APP Application being installed. [default: firefox] 15:53:40 INFO - mkdir: /builds/slave/test/build/application 15:53:40 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'] 15:53:40 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 15:53:56 INFO - Reading from file tmpfile_stdout 15:53:56 INFO - Output received: 15:53:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:56 INFO - Running post-action listener: _resource_record_post_action 15:53:56 INFO - [mozharness: 2016-08-02 22:53:56.510256Z] Finished install step (success) 15:53:56 INFO - [mozharness: 2016-08-02 22:53:56.510531Z] Running run-tests step. 15:53:56 INFO - Running pre-action listener: _resource_record_pre_action 15:53:56 INFO - Running main action method: run_tests 15:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:56 INFO - Python 2.7.3 15:53:56 INFO - Return code: 0 15:53:56 INFO - grabbing minidump binary from tooltool 15:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:56 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 0x15183b0>, '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 0x15192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1519740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:56 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 15:53:56 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 15:53:56 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 15:53:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:56 INFO - Return code: 0 15:53:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:56 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/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:53:56 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/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 15:53:56 INFO - Using env: {'DISPLAY': ':0', 15:53:56 INFO - 'HOME': '/home/cltbld', 15:53:56 INFO - 'LANG': 'en_US.UTF-8', 15:53:56 INFO - 'LANGUAGE': 'en_US:en', 15:53:56 INFO - 'LOGNAME': 'cltbld', 15:53:56 INFO - 'MAIL': '/var/mail/cltbld', 15:53:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:56 INFO - 'MOZ_NO_REMOTE': '1', 15:53:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:56 INFO - 'NO_EM_RESTART': '1', 15:53:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:56 INFO - 'PWD': '/builds/slave/test', 15:53:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:56 INFO - 'SHELL': '/bin/bash', 15:53:56 INFO - 'SHLVL': '1', 15:53:56 INFO - 'TERM': 'linux', 15:53:56 INFO - 'TMOUT': '86400', 15:53:56 INFO - 'USER': 'cltbld', 15:53:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521', 15:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:56 INFO - '_': '/tools/buildbot/bin/python'} 15:53:56 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/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 15:53:56 INFO - mozversion application_buildid: 20160802153150 15:53:56 INFO - mozversion application_changeset: 7ab959c316fca2fc209431491644af62bb93dbdc 15:53:56 INFO - mozversion application_display_name: Nightly 15:53:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:56 INFO - mozversion application_name: Firefox 15:53:56 INFO - mozversion application_remotingname: firefox 15:53:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:53:56 INFO - mozversion application_vendor: Mozilla 15:53:56 INFO - mozversion application_version: 51.0a1 15:53:56 INFO - mozversion platform_buildid: 20160802153150 15:53:56 INFO - mozversion platform_changeset: 7ab959c316fca2fc209431491644af62bb93dbdc 15:53:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:53:56 INFO - mozversion platform_version: 51.0a1 15:53:56 INFO - using testdate: 1470178436 15:53:56 INFO - actual date: 1470178436 15:53:56 INFO - starting webserver on 'localhost:40931' 15:53:56 INFO - SUITE-START | Running 2 tests 15:53:56 INFO - TEST-START | dromaeo_css 15:53:56 INFO - operating with platform_type : linux_ 15:53:56 INFO - Initialising browser for dromaeo_css test... 15:53:56 INFO - TEST-INFO | started process 23934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9B8Hb/profile http://localhost:40931/getInfo.html) 15:54:01 INFO - PROCESS | 23934 | __metrics Screen width/height:1600/1200 15:54:01 INFO - PROCESS | 23934 | colorDepth:24 15:54:01 INFO - PROCESS | 23934 | Browser inner width/height: 1024/697 15:54:01 INFO - PROCESS | 23934 | __metrics 15:54:01 INFO - PROCESS | 23934 | 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" 15:54:01 INFO - PROCESS | 23934 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:02 INFO - TEST-INFO | 23934: exit 0 15:54:02 INFO - Browser initialized. 15:54:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:02 INFO - TEST-INFO | started process 24012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9B8Hb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:14 INFO - PROCESS | 24012 | RSS: Main: 157392896 15:54:14 INFO - PROCESS | 24012 | 15:55:05 INFO - PROCESS | 24012 | 1470178505799 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] 15:57:19 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40931/tests/dromaeo/cssquery-ext.html) 15:57:20 INFO - PROCESS | 24012 | RSS: Main: 233365504 15:57:20 INFO - PROCESS | 24012 | 16:00:22 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-ext.html (next: http://localhost:40931/tests/dromaeo/cssquery-jquery.html) 16:00:23 INFO - PROCESS | 24012 | RSS: Main: 250044416 16:00:23 INFO - PROCESS | 24012 | 16:03:25 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40931/tests/dromaeo/cssquery-mootools.html) 16:03:26 INFO - PROCESS | 24012 | RSS: Main: 189177856 16:03:26 INFO - PROCESS | 24012 | 16:06:28 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40931/tests/dromaeo/cssquery-prototype.html) 16:06:28 INFO - PROCESS | 24012 | RSS: Main: 188497920 16:06:28 INFO - PROCESS | 24012 | 16:09:31 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40931/tests/dromaeo/cssquery-yui.html) 16:09:32 INFO - PROCESS | 24012 | RSS: Main: 190173184 16:09:32 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | Cycle 1(1): loaded http://localhost:40931/tests/dromaeo/cssquery-yui.html (next: http://localhost:40931/tests/dromaeo/cssquery-dojo.html) 16:12:35 INFO - PROCESS | 24012 | RSS: Main: 281210880 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | __start_tp_report 16:12:35 INFO - PROCESS | 24012 | _x_x_mozilla_page_load 16:12:35 INFO - PROCESS | 24012 | _x_x_mozilla_page_load_details 16:12:35 INFO - PROCESS | 24012 | |i|pagename|runs| 16:12:35 INFO - PROCESS | 24012 | |0;dojo.html;2676.2372723773724;2692.609571612115;2719.415325704974;2727.0864260472727;2735.6853961794386;4740.170470167715;4790.904181916359;4806.255030470278;4948.430930442995;4967.950320496794;4827.227643577028;4848.393950756155;4866.343043689101;4886.169351210294;4887.511248875111;4473.88815279619;4474.798634061459;4483.125790470859;4493.842715504958;4545.159145558066;4492.775361231926;4520.095980803836;4560.931586026212;4571.977140114294;4637.675362724611;4583.850374512236;4596.149712303235;4600.056988317387;4634.073185362924;4644.628429725613;4361.236783562864;4375.387445757597;4438.245498265303;4535.024969631545;4544.045750392422;4407.757573333465;4419.071994881079;4427.114577084564;4431.800568974404;4509.25597276449;4899.681520701143;4900.142475066849;4918.336024636664;4947.802087916479;4953.504649535053;5061.063703214917;5179.430262671103;5248.5538729208065;5292.629515933886;5299.178627312773;5209.505097015777;5247.711375874325;5292.788288468457;5293.708846013467;5295.0468915595175;4877.3903262092235;4912.115819152551;4914.410270767531;4922.360093187863;4923.138450771101;5199.6880187188135;5307.071262529042;5381.354237491526;5409.486098820606;5412.3505179377935;5169.198774190007;5191.480851914778;5216.113260745607;5224.451432599599;5226.895462090737;5256.395514515803;5257.684538927677;5259.815906443256;5294.232336311214;5317.441668624816;5068.594512438996;5096.974515127401;5136.306598609214;5201.6358854880555;5220.425753167148;5107.233914912793;5155.097857874857;5160.329157209539;5200.583953283804;5207.062728708793;4456.554344565582;4457.420535330386;4459.375687403766;4465.205674883092;4506.436695413074;3849.942250866239;3855.7108216883844;3903.746256493319;3904.668103211202;3914.236723838881;4380.408644832971;4395.252807022814;4451.332300154938;4460.286354183315;4486.035502367007;5267.130923397596;5274.973625131926;5280.234366016906;5281.287026251483;5285.471452854761;4437.245668236343;4441.977790111029;4445.977770111129;4477.037436951071;4485.887852803706;4619.930701039487;4699.671023028423;4726.1020406122725;4748.928766068511;4790.401199850019;4894.314795928644;4922.114019476457;4930.753462326941;4931.16170251051;4977.527134922177;5277.366715994105;5281.57747380201;5285.180796976475;5287.206918962186;5291.312129423304;4817.855464336076;4890.828820991248;4931.778069986931;4949.851504454872;4994.625403094709;5221.817236396708;5227.89544209106;5227.92158117621;5231.398389185292;5231.973840130775;5298.682079075268;5298.761555729924;5307.363116426053;5308.018016666929;5336.466353364633;4949.059678661043;5073.898522029465;5108.693478391308;5122.974385128051;5233.555147812326;5139.383274007143;5142.100132476877;5172.5344718975475;5178.533931946143;5182.481751824787;5077.669951453144;5107.87230319245;5140.897182056413;5141.331626888481;5152.381714194321;4944.554990050912;5094.388673359221;5096.949030509648;5123.129068058364;5195.506426889439;4965.503449655005;4965.726885021359;4971.900561988812;4975.9004819902675;5066.138756411346 16:12:35 INFO - PROCESS | 24012 | |1;ext.html;565.9518940890024;571.4114462104033;573.6357413042718;579.0648103313148;580.1906340654789;28768.568471472918;40010.79994600027;41467.37798933011;41528.79235603822;45148.77425612867;42248.366274505905;42609.78695106528;42690.786546067306;42736.35895461571;42772.78613606928;7619.19998400167;7741.264579864932;7760.534367937914;7760.573168475732;7764.029496312961;7332.266773322678;7414.184439711627;7414.888776668355;7415.036045314128;7417.147028091785;7408.666610002536;7424.665890034935;7431.331180193782;7451.888221676679;7457.216992215821;7159.928400715979;7175.282471752836;7206.783796486114;7206.927930720678;7217.422606191492;6826.624535650537;6859.07402500661;6865.656717164122;6874.9656251718425;6878.896816547755;39517;39837.601623983675;39839;39882.202355953006;39891.80054099711;2825.1806975976942;2903.419316136781;2904.0852131578695;2990.566367876646;3004.7596192304563;26078.608820867703;26222;26810.865945670146;26826.463470730476;26937.191884243504;3172.857221425041;3183.331500384922;3185.4106990206656;3193.393255281512;3243.789153705002;263133;263209.68395158096;265725;265919;266609;25297.367565811;54480.45519544754;54774;54786;54830.177547336825;31688;33475;33569.32861342759;33594.832025839714;33613.49579756305;12756.936215318863;12890.162139461092;12894.29081400532;12898.161619494704;12901.096923215473;10435.530401131968;10438.68683939483;10447.529861156267;10452.372857628567;10465.633702820365;7073.328033836778;7102.396296314768;7176.605286709281;7215.675294611755;7216.639168041577;3123.0943026522054;3135.874565017419;3170.302533442639;3183.4428974929297;3210.165357007148;753.3558807219748;796.5260669901515;815.8939337886037;866.4194989357146;882.7440042387635;24603.138890138758;25289.367765805633;25413;25638.48723025529;25746.871265643927;927.8329900617819;961.8412961861354;996.0637001218831;1000.3843792275422;1025.3335332034237;13345.266010369329;13653.931730341483;13777.104488208235;14703;15229.202880556246;406324;409746;410022;410436;411244;53319.466805332224;53805.73097134489;53873.1919021215;53984.190237146475;53985.1902221467;1153.7173392518887;1179.6107284596062;1182.6215611004395;1186.5728337798387;1191.2911817468591;28493.430131397672;29725.702742973157;29848.25379365533;30515.389692206474;30579.2355191122;36475.635243648285;40195.79902100588;40754;41027;43589.34615980699;372043;376878;377444;377739;378348;40432.59567404406;40791.388129177496;40821.97945051397;40934.59065409308;41373.172536548496;43521.56478435175;43596.78201608972;43623;43968.34047489226;44577.55422445734;37858.43212351872;37908.61997102184;38084.80957595194;39032.609673902894;39513.407298889964;37860;38157.427638586;38201;39379.6062039376;39502.802485987384;37498.43752343662;37576;38236.617633823305;38240.42639360468;38738.4189237156;28725.28186795347;29062;29470.75821659573;29564.852175738983;29769.851150744107;26215.868920656038;26476;26499.735002650497;26703.732962670125;26704.732952670223 16:12:35 INFO - PROCESS | 24012 | |2;jquery.html;334.73890365514904;364.3314517859727;366.6736604422063;368.8727389050777;387.2216844143273;12529.561465348716;13968.301584920751;14055.718885622282;17168.055756933365;17273.568160795985;15590.298436570352;17598.472045838615;17607.735883961752;17677.292908283653;17751.37870174544;5086.669366491175;5199.402068762103;5324.414314425429;5427.402985671592;5456.508914197721;3505.263894582128;5406.8918621627545;5442.809501667442;5445.101558242885;5445.673259604417;6843.794686159423;7185.640717964081;7208.135023797152;7241.167265764426;7323.267673232687;6890.2420733719;7012.123484564429;7030.894536581955;7033;7119.323664251914;6562.310957349458;6817.795466136024;6824.590524568542;6826.522143449961;6965.094537710116;23216.65175022376;23250.418739531477;23308.60148391102;24232.151874684478;24692;1793.2737241417246;2058.2281644383356;2080.5006798368436;2106.9789302106938;2158.9892050539647;14155.929220353935;14559.490417835324;14993;15193.544193674208;15445.459408920633;1714.3142742902814;1747.1438994892537;1763.2946821271466;1763.700170970938;1974.5655955689726;77822;79901;81763.5911820443;84068;86645;17066.402675906284;17419.390321338946;17487.114626086808;17851.642967140586;18276.54308642268;28859.278518037216;30017.849910750745;30053.39893202124;30434.84782576073;30485;8750.86873696895;8897.199252067345;8935.106489351143;8993.460392376479;9023.413478124032;7100.112485939258;7167.569945803269;7350.595717235603;7522.322990930843;7536.886946695804;8481.872771908425;8569.35729820266;8635.093315201939;8760.649574016968;8804.207621314112;3247.902562923116;3360.24394511233;3424.209269445394;3493.528373669522;3526;702.7294491620763;744.1851172965594;745.9365953893871;747.7607165706921;806.3307454812492;16850.241739121768;17322.826771732372;17429.38997135094;18224.36214732478;19599.90200049019;846.0989046665281;849.0829903703985;878.9912100879037;880.194621920948;942.5475771629656;9729.70810875675;9911.65309214174;10279.126274266622;10292.897071029194;10516.894831051592;283618;285388;286995;399599;408145;83451.1584189101;85952;86057.56971215105;87344.5632771832;88284;915.33638112368;917.4311926605548;937.4609599480326;946.7065209784988;947.166493485742;16254.837451625805;16616.335346586002;16934.15329233558;17031.809511477102;17053.147342632572;26542.336441589116;26546.469070618867;35861.28277434489;37295.694650687095;38207.617923820406;49200.50799491959;52109.7394513025;52393.7380313096;53830.73084634552;55344.72327638336;7061.823454413475;7098.645067746489;7358.742444014434;7420.888686669597;7546.056742907137;7678.692852285846;8432.873506897278;10221.74445638865;10463.372197668165;10921;8643.190962937197;9134.771630709285;9500.857487137837;9801.50992450389;10248.38509689421;9835.409875407498;10125.746856328651;10185.898141018495;10456.477176141314;10471.21465890046;6679.666016699242;8730.91269087301;9933.255005874444;10120.746981325232;10653.72155341364;7550.7734767957045;7601;7709.421793365408;7730.420218483524;7796.298333150044;9123.90876091257;10114.29199955996;10119.848202277119;10163.593456261962;10404.479776011018 16:12:35 INFO - PROCESS | 24012 | |3;mootools.html;1229.538922903911;1362.2235325864256;1401.6986347935194;1438.4030627289676;1570.2384343593349;6364.522660800441;7558.584277864722;7770.766876993699;7776.455648104635;8015.679372825095;7817.413693972961;7880.2513761192595;7881.487703299282;7884.842303153948;7887.211278872124;2203.790639889208;2234.4748983988748;2235.8770267635355;2237.2617036378037;2238.473958619723;2118.5127420693248;2161.2219600943727;2188.059134572133;2191.342597220835;2191.835612329082;2112.355731501899;2120.39568722914;2122.0238690202527;2122.1405330841035;2195.209724499187;2128.872267663945;2131.275366375432;2137.850350475467;2140.518383363746;2143.346279384787;2104.5264815416563;2159.2334721173916;2160.60028894655;2160.837937154704;2161.7513985891665;7654.693812247503;7674.654640541189;7680.807979800494;7726.150123486412;7740.496867703581;4267;4400.823967041314;4406.69153159279;4472.619827314682;4474.172278128557;2833.206702123409;2976.151796737941;3026.107298346993;3028.8485575721124;3039.407315573464;934.8223837470858;936.8360536906014;944.0417975754546;948.9905100948971;955.6082006377352;10627.309224900357;10643;10646;10679.35923844564;10694.465276736131;3997.4403583498333;4068.7355321903983;4098.303288440912;4109.91780164395;4139.379093136054;8555.358348123915;8569;8576.871346929802;8578.699745508877;8583.957080214559;4305.225059489322;4324.675649326313;4328.026194106301;4331.696781225347;4338.045629961403;3343.1307859956587;3685.3919103348185;3853.479780229633;3954.7033972451604;3955.0705584188267;3382.1037425082372;3419.5212670226188;3524.7708898921487;3527.7177825773874;3531.611522732497;1051.990089514075;1092.470151976291;1098.2970898624887;1098.3300186885992;1110.272771334777;593.1873333533088;627.1940556385023;678.2369833936821;685.533836990851;733.3509843788286;4591.747453890001;4616.307553866947;4655.0457156283555;4809.134355815987;4965.0318187953;376.2737915822434;386.5960071725054;390.57427404129635;391.58687584597953;396.3974758367266;3240.8865689700747;3280.2455435250026;3284.261041265744;3294.7199488043784;3361.3445378151514;9524.095180963835;9934.453605051647;9943.751406214902;9959.701208963743;9988.350757200758;9850.408975461496;9868.161206297546;9869.161121304769;9879.506024698736;9879.506024698736;7189.317014883578;7207.351338379676;7277.9636101820215;7285.198628150899;7285.890711639329;4856.368672072608;5001.874953126201;5033.521815427529;5106.974465127799;5311.362636483646;8424.83150337002;8509.659613615386;8510.021347544864;8555.61499732501;8692.434991725517;8438.789030274293;8636;8665.913340866511;8746.475211487332;8756.25571826402;6622.470202383702;6763;6792.592444453348;6913.585184888922;6940.7917762467205;7538.924610753822;7580.05249343832;7581.583012934341;7596.126445458622;7597.544147351176;6684.799456016327;6746.6626668665385;6763.391294783493;6793.66031698423;6980.162380514371;6636.469082473294;6687.899681504684;6731.1922569292;6745.325467453215;6749.696263668048;6163.445289923929;6207.6275423474735;6222.62664240147;6261.56169068179;6273.153124328157;4216.620504154518;4353.259945809156;4395.692301538862;4405.911881762283;4408.426904502394;4365.236083685406;4407.316865885793;4483.14820184164;4500.257457519473;4568.725876447424 16:12:35 INFO - PROCESS | 24012 | |4;prototype.html;297.06720896385355;297.98957036503725;303.2857620304182;305.18819938962355;306.0512411524276;4945.096137986874;4947.8515644530635;4951.876203094925;4964.826231081913;4990.451050384455;4837.854864354066;4894.6539701582;4910.631702622309;4923.163062279412;4930.506949305068;3853.9614603853884;3854.4603755474254;3857.1514266861245;3896.1818018216068;3906.570277269498;3560.7507474476797;3763.3790424580047;3872.2255548890193;3908.7459315144565;3917.5298964124345;3736.9439458408146;3764;3772.792496412696;3788.2802267569073;3799.25914446683;3749.7562658427114;3755.267722794056;3759.32709944075;3761.9247615047548;3777.5089238399105;3148;3168.1604374840686;3222.677732226782;3282.655321191264;3324.8005119692652;4717.339572459859;4719.985203181298;4722.126406614753;4723;4729.4797572267025;4327.437433133704;4347.913041739179;4348.434703488526;4351.6518678505645;4352.564743525654;4825.589824864891;4855.028994201139;5094.77073531692;5097.623641616743;5118.7696553654805;3574.374484465234;3614.7650402724003;3620.7284453665816;3644.5262115925025;3647.1611529348397;5400.243965844785;5411.648242864201;5429.592780541475;5431.809886653988;5456.7544460498975;3557.7865328080397;3696.611855755161;3734.4958430612064;3736.3834967230646;3755.286495565834;3775.414810704345;3785.962140378616;3788.6211378862445;3793.5963693433055;3815.9809200954373;4315.805788739452;4316.402930915581;4329.112531930947;4341.240282950471;4359.738415695068;5095.573239492874;5107.310513080686;5111;5112.642115051911;5112.923306150411;1228.834107395508;1283.345493798151;1298.79868620364;1301.1087405127519;1304.6542666193466;805.4281460163232;821.9876701849477;843.2663582682983;843.9915600843913;848.2577744473585;3932.311845427096;3940.4238304677783;3975.483187185705;3987.282289187916;3993.341098718679;4596.988972223199;4624.676272660881;4633.825829306936;4636.536346365337;4637;3954.853092603113;3959.920801583952;3966.900827479278;3967.4247234150885;3973.7417067890497;2374.9287521374386;2445.2419749877595;2456.459578892641;2456.65606815046;2478.392793765539;4404.8416276025155;4770.356001939694;4832.806687732522;4994.2508623706735;5004.423606563921;5404.189371594213;5425.620206585501;5426.457354264542;5436.646617969819;5459.727013649381;4989.925151122736;4997.875053123628;5008.799648014038;5014.498550145029;5035.816583102895;5061.190209566452;5232.37211534603;5232.607554433356;5247.9766445542755;5279.920801188062;5189.221616757516;5191.92212116811;5199.584033277253;5213.869653258547;5255.0540902637895;4723.385959825201;5001.7749201285305;5029.321041659329;5029.371328583927;5033.798648054037;3780.4518344840394;3822.483964664846;3830.214805964826;3837.5394952604747;3840.3663395539425;5224.555912747459;5261.316028916216;5276.261323414802;5289.7355132244;5291.206319052019;4934.802607895644;5133.332666753298;5133.589312854888;5134.7175905324075;5145.305383773292;5047;5055.7472126392795;5057.140286151437;5069.529836347418;5082.923756143735;4993.850184494471;5015.473375295542;5016.448190699093;5035.622328325464;5063.518965698253;5047.899042019066;5070.138076526926;5166.586673066071;5177.974110129576;5203.164275469802;4975.776090075883;4977.726225057657;4992.350994370854;4994.850154495371;4998.1253280676465 16:12:35 INFO - PROCESS | 24012 | |5;yui.html;581.4127730991698;675.8715843989642;681.7545683553922;682.1370965728355;719.8848184290515;11687.532498700053;12579.748405031894;12613.873861261385;13149.605511834636;13162.407691653874;13360.732785344311;13960.79058814116;14146.504872329471;14710.485133020346;14766.261686915637;777.7550071727402;797.1351084073758;799.6241766369826;799.7320897499345;800.1838125112382;643.8808820368223;748.711745977797;750.2722359311487;757.2503221810396;787.7400457848896;825.4634487583089;830.4270053662983;831.3224721851672;831.6964308027557;831.7005877883956;820.8645573480369;824.0564553586111;824.5094168969454;824.9010118785754;825.162460102996;484.8545436369075;487.60016786235303;495.1780045125075;503.9647224694273;589.1457386789173;12116.636500904899;12527.498900043987;12528;12553.435095420728;12572.748545029139;12179.695507612292;12658.177218480769;12703.491860325576;12744.36278186087;13056.21662700241;11706.941465292704;11743.823842642367;11811.468483918245;11851.407429628483;12006.039516838631;4007.939880901789;4048.4129801178665;4080.3879418087527;4137.8965525861795;4228.471441069866;69193.3080669197;70303.29696703018;70987.29012709859;71446.64276678635;72661.27338726597;9102.453648600873;9379.296552758571;9461.290403219647;9649.951750241204;10122.089011988955;16093.195340232942;16099.517014489584;16110.033397996158;16171.676566468605;16224.269907854175;6387.120220238625;6465.64438955862;6472.935270647327;6511.218653761484;6531.444827189742;3547.6807087362263;3563.768355056913;3588.802615856153;3613.4941108244866;3667.7982710951155;2702.067786613615;2785.832850029005;2791.5393959996777;2809.115128734483;2810.1569529141175;482.29103218269086;494.56478299097284;498.81045202822696;523.5314393617691;539.463234082083;518.7898900945123;530.2708775433779;546.1152932249781;559.3371854352605;571.0891128649797;7011.754588589375;7071.7878463646175;7506.512076714996;7660.119086305146;7717.2282771722375;518.9662671926312;570.7203470299523;588.7909792023855;594.7769586405099;596.8746563221686;3554.1647712787476;3613.313470440608;3644.9817750911075;3681.3557627415094;3811.27585758705;57203.14195287074;65318.67340663266;100297.49851250697;103029;108911.45544272228;93044.53477732568;93645;93835.53082234682;94331.52834235785;94437.5278123605;79330.6033469829;81304.59347703223;81591.7761233582;82261.17738822535;82595.5870220645;6967.53681726843;7031.683574239274;7071.611061391673;7108.466864985044;7213.495055346285;39272.80363598164;40452.59547404606;43756.56243437525;45056.324155138354;48370.75814621045;61743;63814.68092659507;64970;65128.0692368854;67994.66002669955;10404.271700980858;10770.946145269223;10900.509477073392;10995.065419439437;11232.213745037769;11621.477033533341;11803.173777835813;11856.347900865536;12379.257244565355;13394.598162055154;10294.588216471257;10315;10592.629257975934;10784.19118566095;10835.295705779099;10941.343519388862;11097.167712421762;11109.333439993627;11123.27698699582;11318.32090074598;10451.529681164213;10623;10680.359178449007;10930.234883558074;11853.407329633656;8716.520591367536;8952.328575357005;8955.507447090473;9125.224355929555;9221.585028673591;8885.733427997171;9684.70945871625;9782.853257201004;9790.461524616214;9981 16:12:35 INFO - PROCESS | 24012 | __end_tp_report 16:12:35 INFO - PROCESS | 24012 | __start_cc_report 16:12:35 INFO - PROCESS | 24012 | _x_x_mozilla_cycle_collect,1132 16:12:35 INFO - PROCESS | 24012 | __end_cc_report 16:12:35 INFO - PROCESS | 24012 | __startTimestamp1470179555561__endTimestamp 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | ------- Summary: start ------- 16:12:35 INFO - PROCESS | 24012 | Number of tests: 6 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#0] dojo.html Cycles:165 Average:4842.63 Median:4949.85 stddev:517.07 (10.4%) stddev-sans-first:489.93 16:12:35 INFO - PROCESS | 24012 | Values: 2676.2 2692.6 2719.4 2727.1 2735.7 4740.2 4790.9 4806.3 4948.4 4968.0 4827.2 4848.4 4866.3 4886.2 4887.5 4473.9 4474.8 4483.1 4493.8 4545.2 4492.8 4520.1 4560.9 4572.0 4637.7 4583.9 4596.1 4600.1 4634.1 4644.6 4361.2 4375.4 4438.2 4535.0 4544.0 4407.8 4419.1 4427.1 4431.8 4509.3 4899.7 4900.1 4918.3 4947.8 4953.5 5061.1 5179.4 5248.6 5292.6 5299.2 5209.5 5247.7 5292.8 5293.7 5295.0 4877.4 4912.1 4914.4 4922.4 4923.1 5199.7 5307.1 5381.4 5409.5 5412.4 5169.2 5191.5 5216.1 5224.5 5226.9 5256.4 5257.7 5259.8 5294.2 5317.4 5068.6 5097.0 5136.3 5201.6 5220.4 5107.2 5155.1 5160.3 5200.6 5207.1 4456.6 4457.4 4459.4 4465.2 4506.4 3849.9 3855.7 3903.7 3904.7 3914.2 4380.4 4395.3 4451.3 4460.3 4486.0 5267.1 5275.0 5280.2 5281.3 5285.5 4437.2 4442.0 4446.0 4477.0 4485.9 4619.9 4699.7 4726.1 4748.9 4790.4 4894.3 4922.1 4930.8 4931.2 4977.5 5277.4 5281.6 5285.2 5287.2 5291.3 4817.9 4890.8 4931.8 4949.9 4994.6 5221.8 5227.9 5227.9 5231.4 5232.0 5298.7 5298.8 5307.4 5308.0 5336.5 4949.1 5073.9 5108.7 5123.0 5233.6 5139.4 5142.1 5172.5 5178.5 5182.5 5077.7 5107.9 5140.9 5141.3 5152.4 4944.6 5094.4 5096.9 5123.1 5195.5 4965.5 4965.7 4971.9 4975.9 5066.1 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#1] ext.html Cycles:180 Average:49458.98 Median:38885.51 stddev:94158.01 (242.1%) stddev-sans-first:94350.58 16:12:35 INFO - PROCESS | 24012 | Values: 566.0 571.4 573.6 579.1 580.2 28768.6 40010.8 41467.4 41528.8 45148.8 42248.4 42609.8 42690.8 42736.4 42772.8 7619.2 7741.3 7760.5 7760.6 7764.0 7332.3 7414.2 7414.9 7415.0 7417.1 7408.7 7424.7 7431.3 7451.9 7457.2 7159.9 7175.3 7206.8 7206.9 7217.4 6826.6 6859.1 6865.7 6875.0 6878.9 39517.0 39837.6 39839.0 39882.2 39891.8 2825.2 2903.4 2904.1 2990.6 3004.8 26078.6 26222.0 26810.9 26826.5 26937.2 3172.9 3183.3 3185.4 3193.4 3243.8 263133.0 263209.7 265725.0 265919.0 266609.0 25297.4 54480.5 54774.0 54786.0 54830.2 31688.0 33475.0 33569.3 33594.8 33613.5 12756.9 12890.2 12894.3 12898.2 12901.1 10435.5 10438.7 10447.5 10452.4 10465.6 7073.3 7102.4 7176.6 7215.7 7216.6 3123.1 3135.9 3170.3 3183.4 3210.2 753.4 796.5 815.9 866.4 882.7 24603.1 25289.4 25413.0 25638.5 25746.9 927.8 961.8 996.1 1000.4 1025.3 13345.3 13653.9 13777.1 14703.0 15229.2 406324.0 409746.0 410022.0 410436.0 411244.0 53319.5 53805.7 53873.2 53984.2 53985.2 1153.7 1179.6 1182.6 1186.6 1191.3 28493.4 29725.7 29848.3 30515.4 30579.2 36475.6 40195.8 40754.0 41027.0 43589.3 372043.0 376878.0 377444.0 377739.0 378348.0 40432.6 40791.4 40822.0 40934.6 41373.2 43521.6 43596.8 43623.0 43968.3 44577.6 37858.4 37908.6 38084.8 39032.6 39513.4 37860.0 38157.4 38201.0 39379.6 39502.8 37498.4 37576.0 38236.6 38240.4 38738.4 28725.3 29062.0 29470.8 29564.9 29769.9 26215.9 26476.0 26499.7 26703.7 26704.7 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#2] jquery.html Cycles:180 Average:24431.49 Median:28654.57 stddev:56655.28 (197.7%) stddev-sans-first:56785.32 16:12:35 INFO - PROCESS | 24012 | Values: 334.7 364.3 366.7 368.9 387.2 12529.6 13968.3 14055.7 17168.1 17273.6 15590.3 17598.5 17607.7 17677.3 17751.4 5086.7 5199.4 5324.4 5427.4 5456.5 3505.3 5406.9 5442.8 5445.1 5445.7 6843.8 7185.6 7208.1 7241.2 7323.3 6890.2 7012.1 7030.9 7033.0 7119.3 6562.3 6817.8 6824.6 6826.5 6965.1 23216.7 23250.4 23308.6 24232.2 24692.0 1793.3 2058.2 2080.5 2107.0 2159.0 14155.9 14559.5 14993.0 15193.5 15445.5 1714.3 1747.1 1763.3 1763.7 1974.6 77822.0 79901.0 81763.6 84068.0 86645.0 17066.4 17419.4 17487.1 17851.6 18276.5 28859.3 30017.8 30053.4 30434.8 30485.0 8750.9 8897.2 8935.1 8993.5 9023.4 7100.1 7167.6 7350.6 7522.3 7536.9 8481.9 8569.4 8635.1 8760.6 8804.2 3247.9 3360.2 3424.2 3493.5 3526.0 702.7 744.2 745.9 747.8 806.3 16850.2 17322.8 17429.4 18224.4 19599.9 846.1 849.1 879.0 880.2 942.5 9729.7 9911.7 10279.1 10292.9 10516.9 283618.0 285388.0 286995.0 399599.0 408145.0 83451.2 85952.0 86057.6 87344.6 88284.0 915.3 917.4 937.5 946.7 947.2 16254.8 16616.3 16934.2 17031.8 17053.1 26542.3 26546.5 35861.3 37295.7 38207.6 49200.5 52109.7 52393.7 53830.7 55344.7 7061.8 7098.6 7358.7 7420.9 7546.1 7678.7 8432.9 10221.7 10463.4 10921.0 8643.2 9134.8 9500.9 9801.5 10248.4 9835.4 10125.7 10185.9 10456.5 10471.2 6679.7 8730.9 9933.3 10120.7 10653.7 7550.8 7601.0 7709.4 7730.4 7796.3 9123.9 10114.3 10119.8 10163.6 10404.5 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#3] mootools.html Cycles:180 Average:5022.85 Median:4604.03 stddev:2900.65 (63.0%) stddev-sans-first:2894.78 16:12:35 INFO - PROCESS | 24012 | Values: 1229.5 1362.2 1401.7 1438.4 1570.2 6364.5 7558.6 7770.8 7776.5 8015.7 7817.4 7880.3 7881.5 7884.8 7887.2 2203.8 2234.5 2235.9 2237.3 2238.5 2118.5 2161.2 2188.1 2191.3 2191.8 2112.4 2120.4 2122.0 2122.1 2195.2 2128.9 2131.3 2137.9 2140.5 2143.3 2104.5 2159.2 2160.6 2160.8 2161.8 7654.7 7674.7 7680.8 7726.2 7740.5 4267.0 4400.8 4406.7 4472.6 4474.2 2833.2 2976.2 3026.1 3028.8 3039.4 934.8 936.8 944.0 949.0 955.6 10627.3 10643.0 10646.0 10679.4 10694.5 3997.4 4068.7 4098.3 4109.9 4139.4 8555.4 8569.0 8576.9 8578.7 8584.0 4305.2 4324.7 4328.0 4331.7 4338.0 3343.1 3685.4 3853.5 3954.7 3955.1 3382.1 3419.5 3524.8 3527.7 3531.6 1052.0 1092.5 1098.3 1098.3 1110.3 593.2 627.2 678.2 685.5 733.4 4591.7 4616.3 4655.0 4809.1 4965.0 376.3 386.6 390.6 391.6 396.4 3240.9 3280.2 3284.3 3294.7 3361.3 9524.1 9934.5 9943.8 9959.7 9988.4 9850.4 9868.2 9869.2 9879.5 9879.5 7189.3 7207.4 7278.0 7285.2 7285.9 4856.4 5001.9 5033.5 5107.0 5311.4 8424.8 8509.7 8510.0 8555.6 8692.4 8438.8 8636.0 8665.9 8746.5 8756.3 6622.5 6763.0 6792.6 6913.6 6940.8 7538.9 7580.1 7581.6 7596.1 7597.5 6684.8 6746.7 6763.4 6793.7 6980.2 6636.5 6687.9 6731.2 6745.3 6749.7 6163.4 6207.6 6222.6 6261.6 6273.2 4216.6 4353.3 4395.7 4405.9 4408.4 4365.2 4407.3 4483.1 4500.3 4568.7 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#4] prototype.html Cycles:180 Average:4188.29 Median:4726.43 stddev:1243.87 (26.3%) stddev-sans-first:1212.59 16:12:35 INFO - PROCESS | 24012 | Values: 297.1 298.0 303.3 305.2 306.1 4945.1 4947.9 4951.9 4964.8 4990.5 4837.9 4894.7 4910.6 4923.2 4930.5 3854.0 3854.5 3857.2 3896.2 3906.6 3560.8 3763.4 3872.2 3908.7 3917.5 3736.9 3764.0 3772.8 3788.3 3799.3 3749.8 3755.3 3759.3 3761.9 3777.5 3148.0 3168.2 3222.7 3282.7 3324.8 4717.3 4720.0 4722.1 4723.0 4729.5 4327.4 4347.9 4348.4 4351.7 4352.6 4825.6 4855.0 5094.8 5097.6 5118.8 3574.4 3614.8 3620.7 3644.5 3647.2 5400.2 5411.6 5429.6 5431.8 5456.8 3557.8 3696.6 3734.5 3736.4 3755.3 3775.4 3786.0 3788.6 3793.6 3816.0 4315.8 4316.4 4329.1 4341.2 4359.7 5095.6 5107.3 5111.0 5112.6 5112.9 1228.8 1283.3 1298.8 1301.1 1304.7 805.4 822.0 843.3 844.0 848.3 3932.3 3940.4 3975.5 3987.3 3993.3 4597.0 4624.7 4633.8 4636.5 4637.0 3954.9 3959.9 3966.9 3967.4 3973.7 2374.9 2445.2 2456.5 2456.7 2478.4 4404.8 4770.4 4832.8 4994.3 5004.4 5404.2 5425.6 5426.5 5436.6 5459.7 4989.9 4997.9 5008.8 5014.5 5035.8 5061.2 5232.4 5232.6 5248.0 5279.9 5189.2 5191.9 5199.6 5213.9 5255.1 4723.4 5001.8 5029.3 5029.4 5033.8 3780.5 3822.5 3830.2 3837.5 3840.4 5224.6 5261.3 5276.3 5289.7 5291.2 4934.8 5133.3 5133.6 5134.7 5145.3 5047.0 5055.7 5057.1 5069.5 5082.9 4993.9 5015.5 5016.4 5035.6 5063.5 5047.9 5070.1 5166.6 5178.0 5203.2 4975.8 4977.7 4992.4 4994.9 4998.1 16:12:35 INFO - PROCESS | 24012 | 16:12:35 INFO - PROCESS | 24012 | [#5] yui.html Cycles:180 Average:17946.61 Median:511.38 stddev:26501.74 (5182.4%) stddev-sans-first:26544.00 16:12:35 INFO - PROCESS | 24012 | Values: 581.4 675.9 681.8 682.1 719.9 11687.5 12579.7 12613.9 13149.6 13162.4 13360.7 13960.8 14146.5 14710.5 14766.3 777.8 797.1 799.6 799.7 800.2 643.9 748.7 750.3 757.3 787.7 825.5 830.4 831.3 831.7 831.7 820.9 824.1 824.5 824.9 825.2 484.9 487.6 495.2 504.0 589.1 12116.6 12527.5 12528.0 12553.4 12572.7 12179.7 12658.2 12703.5 12744.4 13056.2 11706.9 11743.8 11811.5 11851.4 12006.0 4007.9 4048.4 4080.4 4137.9 4228.5 69193.3 70303.3 70987.3 71446.6 72661.3 9102.5 9379.3 9461.3 9650.0 10122.1 16093.2 16099.5 16110.0 16171.7 16224.3 6387.1 6465.6 6472.9 6511.2 6531.4 3547.7 3563.8 3588.8 3613.5 3667.8 2702.1 2785.8 2791.5 2809.1 2810.2 482.3 494.6 498.8 523.5 539.5 518.8 530.3 546.1 559.3 571.1 7011.8 7071.8 7506.5 7660.1 7717.2 519.0 570.7 588.8 594.8 596.9 3554.2 3613.3 3645.0 3681.4 3811.3 57203.1 65318.7 100297.5 103029.0 108911.5 93044.5 93645.0 93835.5 94331.5 94437.5 79330.6 81304.6 81591.8 82261.2 82595.6 6967.5 7031.7 7071.6 7108.5 7213.5 39272.8 40452.6 43756.6 45056.3 48370.8 61743.0 63814.7 64970.0 65128.1 67994.7 10404.3 10770.9 10900.5 10995.1 11232.2 11621.5 11803.2 11856.3 12379.3 13394.6 10294.6 10315.0 10592.6 10784.2 10835.3 10941.3 11097.2 11109.3 11123.3 11318.3 10451.5 10623.0 10680.4 10930.2 11853.4 8716.5 8952.3 8955.5 9125.2 9221.6 8885.7 9684.7 9782.9 9790.5 9981.0 16:12:35 INFO - PROCESS | 24012 | -------- Summary: end -------- 16:12:35 INFO - PROCESS | 24012 | 16:12:36 INFO - TEST-INFO | 24012: exit 0 16:12:36 INFO - TEST-OK | dromaeo_css | took 1119553ms 16:12:36 INFO - TEST-START | kraken 16:12:36 INFO - operating with platform_type : linux_ 16:12:36 INFO - Initialising browser for kraken test... 16:12:36 INFO - TEST-INFO | started process 24190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NgLoq/profile http://localhost:40931/getInfo.html) 16:12:40 INFO - PROCESS | 24190 | __metrics Screen width/height:1600/1200 16:12:40 INFO - PROCESS | 24190 | colorDepth:24 16:12:40 INFO - PROCESS | 24190 | Browser inner width/height: 1024/697 16:12:40 INFO - PROCESS | 24190 | __metrics 16:12:41 INFO - PROCESS | 24190 | 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" 16:12:41 INFO - PROCESS | 24190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:42 INFO - TEST-INFO | 24190: exit 0 16:12:42 INFO - Browser initialized. 16:12:42 INFO - Running cycle 1/1 for kraken test... 16:12:42 INFO - TEST-INFO | started process 24269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NgLoq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:54 INFO - PROCESS | 24269 | RSS: Main: 157409280 16:12:54 INFO - PROCESS | 24269 | 16:12:57 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40931/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:57 INFO - PROCESS | 24269 | RSS: Main: 213684224 16:12:57 INFO - PROCESS | 24269 | 16:13:00 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40931/tests/kraken/driver.html?testName=audio-dft) 16:13:01 INFO - PROCESS | 24269 | RSS: Main: 192090112 16:13:01 INFO - PROCESS | 24269 | 16:13:04 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40931/tests/kraken/driver.html?testName=audio-fft) 16:13:05 INFO - PROCESS | 24269 | RSS: Main: 270774272 16:13:05 INFO - PROCESS | 24269 | 16:13:07 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40931/tests/kraken/driver.html?testName=audio-oscillator) 16:13:07 INFO - PROCESS | 24269 | RSS: Main: 180137984 16:13:07 INFO - PROCESS | 24269 | 16:13:10 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:10 INFO - PROCESS | 24269 | RSS: Main: 185176064 16:13:10 INFO - PROCESS | 24269 | 16:13:13 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40931/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:14 INFO - PROCESS | 24269 | RSS: Main: 221642752 16:13:14 INFO - PROCESS | 24269 | 16:13:18 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40931/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:18 INFO - PROCESS | 24269 | RSS: Main: 215461888 16:13:18 INFO - PROCESS | 24269 | 16:13:21 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40931/tests/kraken/driver.html?testName=json-parse-financial) 16:13:22 INFO - PROCESS | 24269 | RSS: Main: 218972160 16:13:22 INFO - PROCESS | 24269 | 16:13:23 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:24 INFO - PROCESS | 24269 | RSS: Main: 184311808 16:13:24 INFO - PROCESS | 24269 | 16:13:26 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:27 INFO - PROCESS | 24269 | RSS: Main: 190181376 16:13:27 INFO - PROCESS | 24269 | 16:13:29 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:29 INFO - PROCESS | 24269 | RSS: Main: 194375680 16:13:29 INFO - PROCESS | 24269 | 16:13:32 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:33 INFO - PROCESS | 24269 | RSS: Main: 189120512 16:13:33 INFO - PROCESS | 24269 | 16:13:36 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:36 INFO - PROCESS | 24269 | RSS: Main: 191647744 16:13:36 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | Cycle 1(1): loaded http://localhost:40931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40931/tests/kraken/driver.html?testName=ai-astar) 16:13:38 INFO - PROCESS | 24269 | RSS: Main: 243224576 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | __start_tp_report 16:13:38 INFO - PROCESS | 24269 | _x_x_mozilla_page_load 16:13:38 INFO - PROCESS | 24269 | _x_x_mozilla_page_load_details 16:13:38 INFO - PROCESS | 24269 | |i|pagename|runs| 16:13:38 INFO - PROCESS | 24269 | |0;ai-astar;105;115;115;114;114;114;112;115;115;113 16:13:38 INFO - PROCESS | 24269 | |1;audio-beat-detection;151;123;126;186;122;127;147;127;164;123 16:13:38 INFO - PROCESS | 24269 | |2;audio-dft;163;160;160;161;161;161;162;161;162;161 16:13:38 INFO - PROCESS | 24269 | |3;audio-fft;75;75;77;123;76;78;75;75;111;77 16:13:38 INFO - PROCESS | 24269 | |4;audio-oscillator;85;86;117;86;86;85;127;85;85;125 16:13:38 INFO - PROCESS | 24269 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;118;117;116 16:13:38 INFO - PROCESS | 24269 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;146 16:13:38 INFO - PROCESS | 24269 | |7;imaging-desaturate;95;95;94;96;95;95;95;94;95;95 16:13:38 INFO - PROCESS | 24269 | |8;json-parse-financial;65;62;62;63;64;66;63;62;64;64 16:13:38 INFO - PROCESS | 24269 | |9;json-stringify-tinderbox;66;65;65;66;65;65;66;66;65;67 16:13:38 INFO - PROCESS | 24269 | |10;stanford-crypto-aes;80;78;79;78;78;78;88;77;78;79 16:13:38 INFO - PROCESS | 24269 | |11;stanford-crypto-ccm;130;129;129;135;129;127;129;126;169;135 16:13:38 INFO - PROCESS | 24269 | |12;stanford-crypto-pbkdf2;165;166;165;163;165;165;170;166;168;164 16:13:38 INFO - PROCESS | 24269 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;67;67;67;69;65 16:13:38 INFO - PROCESS | 24269 | __end_tp_report 16:13:38 INFO - PROCESS | 24269 | __start_cc_report 16:13:38 INFO - PROCESS | 24269 | _x_x_mozilla_cycle_collect,1949 16:13:38 INFO - PROCESS | 24269 | __end_cc_report 16:13:38 INFO - PROCESS | 24269 | __startTimestamp1470179618755__endTimestamp 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | ------- Summary: start ------- 16:13:38 INFO - PROCESS | 24269 | Number of tests: 14 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.05 (2.7%) stddev-sans-first:1.05 16:13:38 INFO - PROCESS | 24269 | Values: 105.0 115.0 115.0 114.0 114.0 114.0 112.0 115.0 115.0 113.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:137.00 stddev:21.85 (15.9%) stddev-sans-first:22.78 16:13:38 INFO - PROCESS | 24269 | Values: 151.0 123.0 126.0 186.0 122.0 127.0 147.0 127.0 164.0 123.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 16:13:38 INFO - PROCESS | 24269 | Values: 163.0 160.0 160.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.50 stddev:17.55 (23.2%) stddev-sans-first:18.29 16:13:38 INFO - PROCESS | 24269 | Values: 75.0 75.0 77.0 123.0 76.0 78.0 75.0 75.0 111.0 77.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:18.32 (21.6%) stddev-sans-first:18.94 16:13:38 INFO - PROCESS | 24269 | Values: 85.0 86.0 117.0 86.0 86.0 85.0 127.0 85.0 85.0 125.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:13:38 INFO - PROCESS | 24269 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 116.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:13:38 INFO - PROCESS | 24269 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:13:38 INFO - PROCESS | 24269 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 16:13:38 INFO - PROCESS | 24269 | Values: 65.0 62.0 62.0 63.0 64.0 66.0 63.0 62.0 64.0 64.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 16:13:38 INFO - PROCESS | 24269 | Values: 66.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 65.0 67.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:3.16 (4.0%) stddev-sans-first:3.35 16:13:38 INFO - PROCESS | 24269 | Values: 80.0 78.0 79.0 78.0 78.0 78.0 88.0 77.0 78.0 79.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:129.50 stddev:12.72 (9.8%) stddev-sans-first:13.41 16:13:38 INFO - PROCESS | 24269 | Values: 130.0 129.0 129.0 135.0 129.0 127.0 129.0 126.0 169.0 135.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 16:13:38 INFO - PROCESS | 24269 | Values: 165.0 166.0 165.0 163.0 165.0 165.0 170.0 166.0 168.0 164.0 16:13:38 INFO - PROCESS | 24269 | 16:13:38 INFO - PROCESS | 24269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 16:13:38 INFO - PROCESS | 24269 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 69.0 65.0 16:13:38 INFO - PROCESS | 24269 | -------- Summary: end -------- 16:13:38 INFO - PROCESS | 24269 | 16:13:39 INFO - TEST-INFO | 24269: exit 0 16:13:39 INFO - TEST-OK | kraken | took 63480ms 16:13:39 INFO - SUITE-END | took 1183s 16:13:39 INFO - Completed test suite (00:19:43) 16:13:39 INFO - javascript benchmark 16:13:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.2372723773724, 2692.609571612115, 2719.415325704974, 2727.0864260472727, 2735.6853961794386, 4740.170470167715, 4790.904181916359, 4806.255030470278, 4948.430930442995, 4967.950320496794, 4827.227643577028, 4848.393950756155, 4866.343043689101, 4886.169351210294, 4887.511248875111, 4473.88815279619, 4474.798634061459, 4483.125790470859, 4493.842715504958, 4545.159145558066, 4492.775361231926, 4520.095980803836, 4560.931586026212, 4571.977140114294, 4637.675362724611, 4583.850374512236, 4596.149712303235, 4600.056988317387, 4634.073185362924, 4644.628429725613, 4361.236783562864, 4375.387445757597, 4438.245498265303, 4535.024969631545, 4544.045750392422, 4407.757573333465, 4419.071994881079, 4427.114577084564, 4431.800568974404, 4509.25597276449, 4899.681520701143, 4900.142475066849, 4918.336024636664, 4947.802087916479, 4953.504649535053, 5061.063703214917, 5179.430262671103, 5248.5538729208065, 5292.629515933886, 5299.178627312773, 5209.505097015777, 5247.711375874325, 5292.788288468457, 5293.708846013467, 5295.0468915595175, 4877.3903262092235, 4912.115819152551, 4914.410270767531, 4922.360093187863, 4923.138450771101, 5199.6880187188135, 5307.071262529042, 5381.354237491526, 5409.486098820606, 5412.3505179377935, 5169.198774190007, 5191.480851914778, 5216.113260745607, 5224.451432599599, 5226.895462090737, 5256.395514515803, 5257.684538927677, 5259.815906443256, 5294.232336311214, 5317.441668624816, 5068.594512438996, 5096.974515127401, 5136.306598609214, 5201.6358854880555, 5220.425753167148, 5107.233914912793, 5155.097857874857, 5160.329157209539, 5200.583953283804, 5207.062728708793, 4456.554344565582, 4457.420535330386, 4459.375687403766, 4465.205674883092, 4506.436695413074, 3849.942250866239, 3855.7108216883844, 3903.746256493319, 3904.668103211202, 3914.236723838881, 4380.408644832971, 4395.252807022814, 4451.332300154938, 4460.286354183315, 4486.035502367007, 5267.130923397596, 5274.973625131926, 5280.234366016906, 5281.287026251483, 5285.471452854761, 4437.245668236343, 4441.977790111029, 4445.977770111129, 4477.037436951071, 4485.887852803706, 4619.930701039487, 4699.671023028423, 4726.1020406122725, 4748.928766068511, 4790.401199850019, 4894.314795928644, 4922.114019476457, 4930.753462326941, 4931.16170251051, 4977.527134922177, 5277.366715994105, 5281.57747380201, 5285.180796976475, 5287.206918962186, 5291.312129423304, 4817.855464336076, 4890.828820991248, 4931.778069986931, 4949.851504454872, 4994.625403094709, 5221.817236396708, 5227.89544209106, 5227.92158117621, 5231.398389185292, 5231.973840130775, 5298.682079075268, 5298.761555729924, 5307.363116426053, 5308.018016666929, 5336.466353364633, 4949.059678661043, 5073.898522029465, 5108.693478391308, 5122.974385128051, 5233.555147812326, 5139.383274007143, 5142.100132476877, 5172.5344718975475, 5178.533931946143, 5182.481751824787, 5077.669951453144, 5107.87230319245, 5140.897182056413, 5141.331626888481, 5152.381714194321, 4944.554990050912, 5094.388673359221, 5096.949030509648, 5123.129068058364, 5195.506426889439, 4965.503449655005, 4965.726885021359, 4971.900561988812, 4975.9004819902675, 5066.138756411346], "value": 4808.944508619994, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9518940890024, 571.4114462104033, 573.6357413042718, 579.0648103313148, 580.1906340654789, 28768.568471472918, 40010.79994600027, 41467.37798933011, 41528.79235603822, 45148.77425612867, 42248.366274505905, 42609.78695106528, 42690.786546067306, 42736.35895461571, 42772.78613606928, 7619.19998400167, 7741.264579864932, 7760.534367937914, 7760.573168475732, 7764.029496312961, 7332.266773322678, 7414.184439711627, 7414.888776668355, 7415.036045314128, 7417.147028091785, 7408.666610002536, 7424.665890034935, 7431.331180193782, 7451.888221676679, 7457.216992215821, 7159.928400715979, 7175.282471752836, 7206.783796486114, 7206.927930720678, 7217.422606191492, 6826.624535650537, 6859.07402500661, 6865.656717164122, 6874.9656251718425, 6878.896816547755, 39517.0, 39837.601623983675, 39839.0, 39882.202355953006, 39891.80054099711, 2825.1806975976942, 2903.419316136781, 2904.0852131578695, 2990.566367876646, 3004.7596192304563, 26078.608820867703, 26222.0, 26810.865945670146, 26826.463470730476, 26937.191884243504, 3172.857221425041, 3183.331500384922, 3185.4106990206656, 3193.393255281512, 3243.789153705002, 263133.0, 263209.68395158096, 265725.0, 265919.0, 266609.0, 25297.367565811, 54480.45519544754, 54774.0, 54786.0, 54830.177547336825, 31688.0, 33475.0, 33569.32861342759, 33594.832025839714, 33613.49579756305, 12756.936215318863, 12890.162139461092, 12894.29081400532, 12898.161619494704, 12901.096923215473, 10435.530401131968, 10438.68683939483, 10447.529861156267, 10452.372857628567, 10465.633702820365, 7073.328033836778, 7102.396296314768, 7176.605286709281, 7215.675294611755, 7216.639168041577, 3123.0943026522054, 3135.874565017419, 3170.302533442639, 3183.4428974929297, 3210.165357007148, 753.3558807219748, 796.5260669901515, 815.8939337886037, 866.4194989357146, 882.7440042387635, 24603.138890138758, 25289.367765805633, 25413.0, 25638.48723025529, 25746.871265643927, 927.8329900617819, 961.8412961861354, 996.0637001218831, 1000.3843792275422, 1025.3335332034237, 13345.266010369329, 13653.931730341483, 13777.104488208235, 14703.0, 15229.202880556246, 406324.0, 409746.0, 410022.0, 410436.0, 411244.0, 53319.466805332224, 53805.73097134489, 53873.1919021215, 53984.190237146475, 53985.1902221467, 1153.7173392518887, 1179.6107284596062, 1182.6215611004395, 1186.5728337798387, 1191.2911817468591, 28493.430131397672, 29725.702742973157, 29848.25379365533, 30515.389692206474, 30579.2355191122, 36475.635243648285, 40195.79902100588, 40754.0, 41027.0, 43589.34615980699, 372043.0, 376878.0, 377444.0, 377739.0, 378348.0, 40432.59567404406, 40791.388129177496, 40821.97945051397, 40934.59065409308, 41373.172536548496, 43521.56478435175, 43596.78201608972, 43623.0, 43968.34047489226, 44577.55422445734, 37858.43212351872, 37908.61997102184, 38084.80957595194, 39032.609673902894, 39513.407298889964, 37860.0, 38157.427638586, 38201.0, 39379.6062039376, 39502.802485987384, 37498.43752343662, 37576.0, 38236.617633823305, 38240.42639360468, 38738.4189237156, 28725.28186795347, 29062.0, 29470.75821659573, 29564.852175738983, 29769.851150744107, 26215.868920656038, 26476.0, 26499.735002650497, 26703.732962670125, 26704.732952670223], "value": 16521.047076739287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.73890365514904, 364.3314517859727, 366.6736604422063, 368.8727389050777, 387.2216844143273, 12529.561465348716, 13968.301584920751, 14055.718885622282, 17168.055756933365, 17273.568160795985, 15590.298436570352, 17598.472045838615, 17607.735883961752, 17677.292908283653, 17751.37870174544, 5086.669366491175, 5199.402068762103, 5324.414314425429, 5427.402985671592, 5456.508914197721, 3505.263894582128, 5406.8918621627545, 5442.809501667442, 5445.101558242885, 5445.673259604417, 6843.794686159423, 7185.640717964081, 7208.135023797152, 7241.167265764426, 7323.267673232687, 6890.2420733719, 7012.123484564429, 7030.894536581955, 7033.0, 7119.323664251914, 6562.310957349458, 6817.795466136024, 6824.590524568542, 6826.522143449961, 6965.094537710116, 23216.65175022376, 23250.418739531477, 23308.60148391102, 24232.151874684478, 24692.0, 1793.2737241417246, 2058.2281644383356, 2080.5006798368436, 2106.9789302106938, 2158.9892050539647, 14155.929220353935, 14559.490417835324, 14993.0, 15193.544193674208, 15445.459408920633, 1714.3142742902814, 1747.1438994892537, 1763.2946821271466, 1763.700170970938, 1974.5655955689726, 77822.0, 79901.0, 81763.5911820443, 84068.0, 86645.0, 17066.402675906284, 17419.390321338946, 17487.114626086808, 17851.642967140586, 18276.54308642268, 28859.278518037216, 30017.849910750745, 30053.39893202124, 30434.84782576073, 30485.0, 8750.86873696895, 8897.199252067345, 8935.106489351143, 8993.460392376479, 9023.413478124032, 7100.112485939258, 7167.569945803269, 7350.595717235603, 7522.322990930843, 7536.886946695804, 8481.872771908425, 8569.35729820266, 8635.093315201939, 8760.649574016968, 8804.207621314112, 3247.902562923116, 3360.24394511233, 3424.209269445394, 3493.528373669522, 3526.0, 702.7294491620763, 744.1851172965594, 745.9365953893871, 747.7607165706921, 806.3307454812492, 16850.241739121768, 17322.826771732372, 17429.38997135094, 18224.36214732478, 19599.90200049019, 846.0989046665281, 849.0829903703985, 878.9912100879037, 880.194621920948, 942.5475771629656, 9729.70810875675, 9911.65309214174, 10279.126274266622, 10292.897071029194, 10516.894831051592, 283618.0, 285388.0, 286995.0, 399599.0, 408145.0, 83451.1584189101, 85952.0, 86057.56971215105, 87344.5632771832, 88284.0, 915.33638112368, 917.4311926605548, 937.4609599480326, 946.7065209784988, 947.166493485742, 16254.837451625805, 16616.335346586002, 16934.15329233558, 17031.809511477102, 17053.147342632572, 26542.336441589116, 26546.469070618867, 35861.28277434489, 37295.694650687095, 38207.617923820406, 49200.50799491959, 52109.7394513025, 52393.7380313096, 53830.73084634552, 55344.72327638336, 7061.823454413475, 7098.645067746489, 7358.742444014434, 7420.888686669597, 7546.056742907137, 7678.692852285846, 8432.873506897278, 10221.74445638865, 10463.372197668165, 10921.0, 8643.190962937197, 9134.771630709285, 9500.857487137837, 9801.50992450389, 10248.38509689421, 9835.409875407498, 10125.746856328651, 10185.898141018495, 10456.477176141314, 10471.21465890046, 6679.666016699242, 8730.91269087301, 9933.255005874444, 10120.746981325232, 10653.72155341364, 7550.7734767957045, 7601.0, 7709.421793365408, 7730.420218483524, 7796.298333150044, 9123.90876091257, 10114.29199955996, 10119.848202277119, 10163.593456261962, 10404.479776011018], "value": 9153.208321779022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.538922903911, 1362.2235325864256, 1401.6986347935194, 1438.4030627289676, 1570.2384343593349, 6364.522660800441, 7558.584277864722, 7770.766876993699, 7776.455648104635, 8015.679372825095, 7817.413693972961, 7880.2513761192595, 7881.487703299282, 7884.842303153948, 7887.211278872124, 2203.790639889208, 2234.4748983988748, 2235.8770267635355, 2237.2617036378037, 2238.473958619723, 2118.5127420693248, 2161.2219600943727, 2188.059134572133, 2191.342597220835, 2191.835612329082, 2112.355731501899, 2120.39568722914, 2122.0238690202527, 2122.1405330841035, 2195.209724499187, 2128.872267663945, 2131.275366375432, 2137.850350475467, 2140.518383363746, 2143.346279384787, 2104.5264815416563, 2159.2334721173916, 2160.60028894655, 2160.837937154704, 2161.7513985891665, 7654.693812247503, 7674.654640541189, 7680.807979800494, 7726.150123486412, 7740.496867703581, 4267.0, 4400.823967041314, 4406.69153159279, 4472.619827314682, 4474.172278128557, 2833.206702123409, 2976.151796737941, 3026.107298346993, 3028.8485575721124, 3039.407315573464, 934.8223837470858, 936.8360536906014, 944.0417975754546, 948.9905100948971, 955.6082006377352, 10627.309224900357, 10643.0, 10646.0, 10679.35923844564, 10694.465276736131, 3997.4403583498333, 4068.7355321903983, 4098.303288440912, 4109.91780164395, 4139.379093136054, 8555.358348123915, 8569.0, 8576.871346929802, 8578.699745508877, 8583.957080214559, 4305.225059489322, 4324.675649326313, 4328.026194106301, 4331.696781225347, 4338.045629961403, 3343.1307859956587, 3685.3919103348185, 3853.479780229633, 3954.7033972451604, 3955.0705584188267, 3382.1037425082372, 3419.5212670226188, 3524.7708898921487, 3527.7177825773874, 3531.611522732497, 1051.990089514075, 1092.470151976291, 1098.2970898624887, 1098.3300186885992, 1110.272771334777, 593.1873333533088, 627.1940556385023, 678.2369833936821, 685.533836990851, 733.3509843788286, 4591.747453890001, 4616.307553866947, 4655.0457156283555, 4809.134355815987, 4965.0318187953, 376.2737915822434, 386.5960071725054, 390.57427404129635, 391.58687584597953, 396.3974758367266, 3240.8865689700747, 3280.2455435250026, 3284.261041265744, 3294.7199488043784, 3361.3445378151514, 9524.095180963835, 9934.453605051647, 9943.751406214902, 9959.701208963743, 9988.350757200758, 9850.408975461496, 9868.161206297546, 9869.161121304769, 9879.506024698736, 9879.506024698736, 7189.317014883578, 7207.351338379676, 7277.9636101820215, 7285.198628150899, 7285.890711639329, 4856.368672072608, 5001.874953126201, 5033.521815427529, 5106.974465127799, 5311.362636483646, 8424.83150337002, 8509.659613615386, 8510.021347544864, 8555.61499732501, 8692.434991725517, 8438.789030274293, 8636.0, 8665.913340866511, 8746.475211487332, 8756.25571826402, 6622.470202383702, 6763.0, 6792.592444453348, 6913.585184888922, 6940.7917762467205, 7538.924610753822, 7580.05249343832, 7581.583012934341, 7596.126445458622, 7597.544147351176, 6684.799456016327, 6746.6626668665385, 6763.391294783493, 6793.66031698423, 6980.162380514371, 6636.469082473294, 6687.899681504684, 6731.1922569292, 6745.325467453215, 6749.696263668048, 6163.445289923929, 6207.6275423474735, 6222.62664240147, 6261.56169068179, 6273.153124328157, 4216.620504154518, 4353.259945809156, 4395.692301538862, 4405.911881762283, 4408.426904502394, 4365.236083685406, 4407.316865885793, 4483.14820184164, 4500.257457519473, 4568.725876447424], "value": 3934.3205171763193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.06720896385355, 297.98957036503725, 303.2857620304182, 305.18819938962355, 306.0512411524276, 4945.096137986874, 4947.8515644530635, 4951.876203094925, 4964.826231081913, 4990.451050384455, 4837.854864354066, 4894.6539701582, 4910.631702622309, 4923.163062279412, 4930.506949305068, 3853.9614603853884, 3854.4603755474254, 3857.1514266861245, 3896.1818018216068, 3906.570277269498, 3560.7507474476797, 3763.3790424580047, 3872.2255548890193, 3908.7459315144565, 3917.5298964124345, 3736.9439458408146, 3764.0, 3772.792496412696, 3788.2802267569073, 3799.25914446683, 3749.7562658427114, 3755.267722794056, 3759.32709944075, 3761.9247615047548, 3777.5089238399105, 3148.0, 3168.1604374840686, 3222.677732226782, 3282.655321191264, 3324.8005119692652, 4717.339572459859, 4719.985203181298, 4722.126406614753, 4723.0, 4729.4797572267025, 4327.437433133704, 4347.913041739179, 4348.434703488526, 4351.6518678505645, 4352.564743525654, 4825.589824864891, 4855.028994201139, 5094.77073531692, 5097.623641616743, 5118.7696553654805, 3574.374484465234, 3614.7650402724003, 3620.7284453665816, 3644.5262115925025, 3647.1611529348397, 5400.243965844785, 5411.648242864201, 5429.592780541475, 5431.809886653988, 5456.7544460498975, 3557.7865328080397, 3696.611855755161, 3734.4958430612064, 3736.3834967230646, 3755.286495565834, 3775.414810704345, 3785.962140378616, 3788.6211378862445, 3793.5963693433055, 3815.9809200954373, 4315.805788739452, 4316.402930915581, 4329.112531930947, 4341.240282950471, 4359.738415695068, 5095.573239492874, 5107.310513080686, 5111.0, 5112.642115051911, 5112.923306150411, 1228.834107395508, 1283.345493798151, 1298.79868620364, 1301.1087405127519, 1304.6542666193466, 805.4281460163232, 821.9876701849477, 843.2663582682983, 843.9915600843913, 848.2577744473585, 3932.311845427096, 3940.4238304677783, 3975.483187185705, 3987.282289187916, 3993.341098718679, 4596.988972223199, 4624.676272660881, 4633.825829306936, 4636.536346365337, 4637.0, 3954.853092603113, 3959.920801583952, 3966.900827479278, 3967.4247234150885, 3973.7417067890497, 2374.9287521374386, 2445.2419749877595, 2456.459578892641, 2456.65606815046, 2478.392793765539, 4404.8416276025155, 4770.356001939694, 4832.806687732522, 4994.2508623706735, 5004.423606563921, 5404.189371594213, 5425.620206585501, 5426.457354264542, 5436.646617969819, 5459.727013649381, 4989.925151122736, 4997.875053123628, 5008.799648014038, 5014.498550145029, 5035.816583102895, 5061.190209566452, 5232.37211534603, 5232.607554433356, 5247.9766445542755, 5279.920801188062, 5189.221616757516, 5191.92212116811, 5199.584033277253, 5213.869653258547, 5255.0540902637895, 4723.385959825201, 5001.7749201285305, 5029.321041659329, 5029.371328583927, 5033.798648054037, 3780.4518344840394, 3822.483964664846, 3830.214805964826, 3837.5394952604747, 3840.3663395539425, 5224.555912747459, 5261.316028916216, 5276.261323414802, 5289.7355132244, 5291.206319052019, 4934.802607895644, 5133.332666753298, 5133.589312854888, 5134.7175905324075, 5145.305383773292, 5047.0, 5055.7472126392795, 5057.140286151437, 5069.529836347418, 5082.923756143735, 4993.850184494471, 5015.473375295542, 5016.448190699093, 5035.622328325464, 5063.518965698253, 5047.899042019066, 5070.138076526926, 5166.586673066071, 5177.974110129576, 5203.164275469802, 4975.776090075883, 4977.726225057657, 4992.350994370854, 4994.850154495371, 4998.1253280676465], "value": 3792.442528928007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4127730991698, 675.8715843989642, 681.7545683553922, 682.1370965728355, 719.8848184290515, 11687.532498700053, 12579.748405031894, 12613.873861261385, 13149.605511834636, 13162.407691653874, 13360.732785344311, 13960.79058814116, 14146.504872329471, 14710.485133020346, 14766.261686915637, 777.7550071727402, 797.1351084073758, 799.6241766369826, 799.7320897499345, 800.1838125112382, 643.8808820368223, 748.711745977797, 750.2722359311487, 757.2503221810396, 787.7400457848896, 825.4634487583089, 830.4270053662983, 831.3224721851672, 831.6964308027557, 831.7005877883956, 820.8645573480369, 824.0564553586111, 824.5094168969454, 824.9010118785754, 825.162460102996, 484.8545436369075, 487.60016786235303, 495.1780045125075, 503.9647224694273, 589.1457386789173, 12116.636500904899, 12527.498900043987, 12528.0, 12553.435095420728, 12572.748545029139, 12179.695507612292, 12658.177218480769, 12703.491860325576, 12744.36278186087, 13056.21662700241, 11706.941465292704, 11743.823842642367, 11811.468483918245, 11851.407429628483, 12006.039516838631, 4007.939880901789, 4048.4129801178665, 4080.3879418087527, 4137.8965525861795, 4228.471441069866, 69193.3080669197, 70303.29696703018, 70987.29012709859, 71446.64276678635, 72661.27338726597, 9102.453648600873, 9379.296552758571, 9461.290403219647, 9649.951750241204, 10122.089011988955, 16093.195340232942, 16099.517014489584, 16110.033397996158, 16171.676566468605, 16224.269907854175, 6387.120220238625, 6465.64438955862, 6472.935270647327, 6511.218653761484, 6531.444827189742, 3547.6807087362263, 3563.768355056913, 3588.802615856153, 3613.4941108244866, 3667.7982710951155, 2702.067786613615, 2785.832850029005, 2791.5393959996777, 2809.115128734483, 2810.1569529141175, 482.29103218269086, 494.56478299097284, 498.81045202822696, 523.5314393617691, 539.463234082083, 518.7898900945123, 530.2708775433779, 546.1152932249781, 559.3371854352605, 571.0891128649797, 7011.754588589375, 7071.7878463646175, 7506.512076714996, 7660.119086305146, 7717.2282771722375, 518.9662671926312, 570.7203470299523, 588.7909792023855, 594.7769586405099, 596.8746563221686, 3554.1647712787476, 3613.313470440608, 3644.9817750911075, 3681.3557627415094, 3811.27585758705, 57203.14195287074, 65318.67340663266, 100297.49851250697, 103029.0, 108911.45544272228, 93044.53477732568, 93645.0, 93835.53082234682, 94331.52834235785, 94437.5278123605, 79330.6033469829, 81304.59347703223, 81591.7761233582, 82261.17738822535, 82595.5870220645, 6967.53681726843, 7031.683574239274, 7071.611061391673, 7108.466864985044, 7213.495055346285, 39272.80363598164, 40452.59547404606, 43756.56243437525, 45056.324155138354, 48370.75814621045, 61743.0, 63814.68092659507, 64970.0, 65128.0692368854, 67994.66002669955, 10404.271700980858, 10770.946145269223, 10900.509477073392, 10995.065419439437, 11232.213745037769, 11621.477033533341, 11803.173777835813, 11856.347900865536, 12379.257244565355, 13394.598162055154, 10294.588216471257, 10315.0, 10592.629257975934, 10784.19118566095, 10835.295705779099, 10941.343519388862, 11097.167712421762, 11109.333439993627, 11123.27698699582, 11318.32090074598, 10451.529681164213, 10623.0, 10680.359178449007, 10930.234883558074, 11853.407329633656, 8716.520591367536, 8952.328575357005, 8955.507447090473, 9125.224355929555, 9221.585028673591, 8885.733427997171, 9684.70945871625, 9782.853257201004, 9790.461524616214, 9981.0], "value": 6411.721230676413, "unit": "score"}], "name": "dromaeo_css", "value": 6413.263280571904, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 114.0, 114.0, 114.0, 112.0, 115.0, 115.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 126.0, 186.0, 122.0, 127.0, 147.0, 127.0, 164.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 123.0, 76.0, 78.0, 75.0, 75.0, 111.0, 77.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 117.0, 86.0, 86.0, 85.0, 127.0, 85.0, 85.0, 125.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 64.0, 66.0, 63.0, 62.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 78.0, 78.0, 78.0, 88.0, 77.0, 78.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 129.0, 135.0, 129.0, 127.0, 129.0, 126.0, 169.0, 135.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 165.0, 163.0, 165.0, 165.0, 170.0, 166.0, 168.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1527.4999999999998, "alertThreshold": 2.0}]} 16:13:39 INFO - Return code: 0 16:13:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:40 INFO - # TBPL SUCCESS # 16:13:40 INFO - Running post-action listener: _resource_record_post_action 16:13:40 INFO - [mozharness: 2016-08-02 23:13:40.035205Z] Finished run-tests step (success) 16:13:40 INFO - Running post-run listener: _resource_record_post_run 16:13:40 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 532422656; Read time: 0; Write time: 327228 16:13:40 INFO - TinderboxPrint: CPU usage
13.0% 16:13:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:13:40 INFO - TinderboxPrint: I/O write bytes / time
532,422,656 / 327,228 16:13:40 INFO - TinderboxPrint: CPU idle
8,326.1 (87.0%) 16:13:40 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 16:13:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236900352; Read time: 0; Write time: 171820 16:13:40 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283648000; Read time: 0; Write time: 153840 16:13:40 INFO - Running post-run listener: _upload_blobber_files 16:13:40 INFO - Blob upload gear active. 16:13:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:40 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 16:13:40 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'] 16:13:40 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 16:13:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:42 INFO - (blobuploader) - INFO - Done attempting. 16:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:42 INFO - (blobuploader) - INFO - Done attempting. 16:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:46 INFO - (blobuploader) - INFO - Done attempting. 16:13:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:46 INFO - Return code: 0 16:13:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5b480bad57aef86b385c04a9ffd0598d1a63ebe14b57eed3a8d915c8452487961dd9f771665507978b0a080a37dd89a8dac8efd3c008480a2672aecfe7891a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a2a2c369f63dffa1000a40c704d18ba276e4c134d2c32b3b8d52450cba49dd2e8c63585fe33c3b4b5fc0230487d7ea4ca6d0dd8f1677bb09099d10b230b0f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ba4f5f4c7fa6aa97226e08b509e3eb22cb1f483710c35a6cb1d88de807cc17a1d819c93111c3d05e4e551e5710024c3abef13a69f2e5350a51e68de7676579b"} 16:13:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:46 INFO - Contents: 16:13:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5b480bad57aef86b385c04a9ffd0598d1a63ebe14b57eed3a8d915c8452487961dd9f771665507978b0a080a37dd89a8dac8efd3c008480a2672aecfe7891a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a2a2c369f63dffa1000a40c704d18ba276e4c134d2c32b3b8d52450cba49dd2e8c63585fe33c3b4b5fc0230487d7ea4ca6d0dd8f1677bb09099d10b230b0f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ba4f5f4c7fa6aa97226e08b509e3eb22cb1f483710c35a6cb1d88de807cc17a1d819c93111c3d05e4e551e5710024c3abef13a69f2e5350a51e68de7676579b"} 16:13:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:46 INFO - Copying logs to upload dir... 16:13:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.706781 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-02 16:13:46.263248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 16:13:46.267767) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 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/5b480bad57aef86b385c04a9ffd0598d1a63ebe14b57eed3a8d915c8452487961dd9f771665507978b0a080a37dd89a8dac8efd3c008480a2672aecfe7891a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a2a2c369f63dffa1000a40c704d18ba276e4c134d2c32b3b8d52450cba49dd2e8c63585fe33c3b4b5fc0230487d7ea4ca6d0dd8f1677bb09099d10b230b0f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ba4f5f4c7fa6aa97226e08b509e3eb22cb1f483710c35a6cb1d88de807cc17a1d819c93111c3d05e4e551e5710024c3abef13a69f2e5350a51e68de7676579b"} build_url:https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/Dew9K8wmRFOjkAPggDmRXw/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/5b480bad57aef86b385c04a9ffd0598d1a63ebe14b57eed3a8d915c8452487961dd9f771665507978b0a080a37dd89a8dac8efd3c008480a2672aecfe7891a2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2a2a2c369f63dffa1000a40c704d18ba276e4c134d2c32b3b8d52450cba49dd2e8c63585fe33c3b4b5fc0230487d7ea4ca6d0dd8f1677bb09099d10b230b0f4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ba4f5f4c7fa6aa97226e08b509e3eb22cb1f483710c35a6cb1d88de807cc17a1d819c93111c3d05e4e551e5710024c3abef13a69f2e5350a51e68de7676579b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 16:13:46.295841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:13:46.296313) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470178025.823891-1748555521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 16:13:46.382859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 16:13:46.383781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 16:13:46.384651) ========= ========= Total master_lag: 0.19 =========