builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1470262994.52 results: success (0) buildid: 20160803140449 builduid: 93c39ec2d846420c8aa31ce5d56f7c9a revision: de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.520035) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.520463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.520787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.543784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.544162) ========= 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=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 15:23:14-- 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% 66.8M=0s 2016-08-03 15:23:14 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.662889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.663223) ========= 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=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020474 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.714805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:14.715205) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a --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=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 15:23:15,048 truncating revision to first 12 chars 2016-08-03 15:23:15,048 Setting DEBUG logging. 2016-08-03 15:23:15,048 attempt 1/10 2016-08-03 15:23:15,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de6fd5bb93d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 15:23:15,346 unpacking tar archive at: mozilla-central-de6fd5bb93d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:15.354281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:15.354599) ========= script_repo_revision: de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:15.354997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:15.355316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 15:23:15.366620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 15:23:15.367013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:15 INFO - MultiFileLogger online at 20160803 15:23:15 in /builds/slave/test 15:23:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:23:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:15 INFO - {'append_to_log': False, 15:23:15 INFO - 'base_work_dir': '/builds/slave/test', 15:23:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:23:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:15 INFO - 'branch': 'Firefox-Non-PGO', 15:23:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:15 INFO - 'config_files': ('talos/linux_config.py',), 15:23:15 INFO - 'default_actions': ('clobber', 15:23:15 INFO - 'read-buildbot-config', 15:23:15 INFO - 'download-and-extract', 15:23:15 INFO - 'populate-webroot', 15:23:15 INFO - 'create-virtualenv', 15:23:15 INFO - 'install', 15:23:15 INFO - 'run-tests'), 15:23:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:15 INFO - 'download_minidump_stackwalk': True, 15:23:15 INFO - 'download_symbols': 'ondemand', 15:23:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:15 INFO - 'installer_path': 'installer.exe', 15:23:15 INFO - 'log_level': 'info', 15:23:15 INFO - 'log_name': 'talos', 15:23:15 INFO - 'log_to_console': True, 15:23:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:15 INFO - 'opt_config_files': (), 15:23:15 INFO - 'pip_index': False, 15:23:15 INFO - 'sps_profile': False, 15:23:15 INFO - 'sps_profile_interval': 0, 15:23:15 INFO - 'suite': 'dromaeojs', 15:23:15 INFO - 'system_bits': '32', 15:23:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:15 INFO - 'title': 'talos-linux64-ix-008', 15:23:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:15 INFO - 'use_talos_json': True, 15:23:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:15 INFO - 'work_dir': 'build'} 15:23:15 INFO - [mozharness: 2016-08-03 22:23:15.793229Z] Running clobber step. 15:23:15 INFO - Running pre-action listener: _resource_record_pre_action 15:23:15 INFO - Running main action method: clobber 15:23:15 INFO - rmtree: /builds/slave/test/build 15:23:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:16 INFO - Running post-action listener: _resource_record_post_action 15:23:16 INFO - [mozharness: 2016-08-03 22:23:16.255430Z] Finished clobber step (success) 15:23:16 INFO - [mozharness: 2016-08-03 22:23:16.255531Z] Running read-buildbot-config step. 15:23:16 INFO - Running pre-action listener: _resource_record_pre_action 15:23:16 INFO - Running main action method: read_buildbot_config 15:23:16 INFO - Using buildbot properties: 15:23:16 INFO - { 15:23:16 INFO - "project": "", 15:23:16 INFO - "product": "firefox", 15:23:16 INFO - "script_repo_revision": "production", 15:23:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:23:16 INFO - "repository": "", 15:23:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:23:16 INFO - "buildid": "20160803140449", 15:23:16 INFO - "pgo_build": "False", 15:23:16 INFO - "basedir": "/builds/slave/test", 15:23:16 INFO - "buildnumber": 581, 15:23:16 INFO - "slavename": "talos-linux64-ix-008", 15:23:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:16 INFO - "platform": "ubuntu64_hw", 15:23:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:23:16 INFO - "branch": "mozilla-central", 15:23:16 INFO - "repo_path": "mozilla-central", 15:23:16 INFO - "revision": "de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a", 15:23:16 INFO - "stage_platform": "linux64", 15:23:16 INFO - "builduid": "93c39ec2d846420c8aa31ce5d56f7c9a", 15:23:16 INFO - "slavebuilddir": "test" 15:23:16 INFO - } 15:23:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:23:16 INFO - Running post-action listener: _resource_record_post_action 15:23:16 INFO - [mozharness: 2016-08-03 22:23:16.257974Z] Finished read-buildbot-config step (success) 15:23:16 INFO - [mozharness: 2016-08-03 22:23:16.258063Z] Running download-and-extract step. 15:23:16 INFO - Running pre-action listener: _resource_record_pre_action 15:23:16 INFO - Running main action method: download_and_extract 15:23:16 INFO - mkdir: /builds/slave/test/build/tests 15:23: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:23:16 INFO - https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:17 INFO - Downloaded 1361 bytes. 15:23:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:23:17 INFO - Using the following test package requirements: 15:23:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:23:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:23:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'jsshell-linux-x86_64.zip'], 15:23:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:23:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:23:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:23:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:23:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:23:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:17 INFO - https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:18 INFO - Downloaded 20241121 bytes. 15:23:18 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:23:18 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:23:20 INFO - Return code: 0 15:23:20 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:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:20 INFO - https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:21 INFO - Downloaded 20241121 bytes. 15:23:21 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:23:21 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:23:23 INFO - Return code: 0 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:23 INFO - https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:23 INFO - Downloaded 14413723 bytes. 15:23:23 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:23:23 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:23:24 INFO - Return code: 0 15:23: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:23:24 INFO - https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSKGS-coSTiTB6jODSgOOQ/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:23:25 INFO - Downloaded 55583060 bytes. 15:23:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:23:25 INFO - mkdir: /builds/slave/test/properties 15:23:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:23:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:23:25 INFO - Contents: 15:23:25 INFO - build_url:https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:23:26 INFO - Running post-action listener: _resource_record_post_action 15:23:26 INFO - Running post-action listener: set_extra_try_arguments 15:23:26 INFO - [mozharness: 2016-08-03 22:23:26.041227Z] Finished download-and-extract step (success) 15:23:26 INFO - [mozharness: 2016-08-03 22:23:26.041460Z] Running populate-webroot step. 15:23:26 INFO - Running pre-action listener: _resource_record_pre_action 15:23:26 INFO - Running main action method: populate_webroot 15:23:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:26 INFO - '--tppagecycles', 15:23:26 INFO - '7'], 15:23:26 INFO - 'tests': ['tsvgm']}}, 15:23:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:23:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:23:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:23:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['damp', 'tps']}, 15:23:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'tests': ['damp', 'tps']}, 15:23:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['dromaeo_dom']}, 15:23:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['basic_compositor_video']}, 15:23:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:23:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['a11yr', 15:23:26 INFO - 'ts_paint', 15:23:26 INFO - 'tpaint', 15:23:26 INFO - 'sessionrestore', 15:23:26 INFO - 'sessionrestore_no_auto_restore', 15:23:26 INFO - 'tabpaint']}, 15:23:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['tsvgx', 15:23:26 INFO - 'tsvgr_opacity', 15:23:26 INFO - 'tart', 15:23:26 INFO - 'tscrollx', 15:23:26 INFO - 'cart']}, 15:23:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:23:26 INFO - 'tsvgr_opacity', 15:23:26 INFO - 'tart', 15:23:26 INFO - 'tscrollx', 15:23:26 INFO - 'cart']}, 15:23:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'talos_options': ['--disable-e10s'], 15:23:26 INFO - 'tests': ['tp5o']}, 15:23:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'tests': ['tp5o']}, 15:23:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'talos_options': ['--disable-e10s', 15:23:26 INFO - '--xperf_path', 15:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:26 INFO - 'tests': ['tp5n']}, 15:23:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:26 INFO - 'talos_options': ['--xperf_path', 15:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:26 INFO - 'tests': ['tp5n']}}, 15:23:26 INFO - 'talos.zip': {'path': '', 15:23:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:26 INFO - Running post-action listener: _resource_record_post_action 15:23:26 INFO - [mozharness: 2016-08-03 22:23:26.061923Z] Finished populate-webroot step (success) 15:23:26 INFO - [mozharness: 2016-08-03 22:23:26.062012Z] Running create-virtualenv step. 15:23:26 INFO - Running pre-action listener: _resource_record_pre_action 15:23:26 INFO - Running main action method: create_virtualenv 15:23:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:23:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:23:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:23:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:26 INFO - Using real prefix '/usr' 15:23:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:23:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:28 INFO - Installing pip.................done. 15:23:28 INFO - Return code: 0 15:23:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:23: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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:23:28 INFO - Using env: {'DISPLAY': ':0', 15:23:28 INFO - 'HOME': '/home/cltbld', 15:23:28 INFO - 'LANG': 'en_US.UTF-8', 15:23:28 INFO - 'LANGUAGE': 'en_US:en', 15:23:28 INFO - 'LOGNAME': 'cltbld', 15:23:28 INFO - 'MAIL': '/var/mail/cltbld', 15:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:28 INFO - 'MOZ_NO_REMOTE': '1', 15:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:28 INFO - 'NO_EM_RESTART': '1', 15:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:28 INFO - 'PWD': '/builds/slave/test', 15:23:28 INFO - 'SHELL': '/bin/bash', 15:23:28 INFO - 'SHLVL': '1', 15:23:28 INFO - 'TERM': 'linux', 15:23:28 INFO - 'TMOUT': '86400', 15:23:28 INFO - 'USER': 'cltbld', 15:23:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:28 INFO - '_': '/tools/buildbot/bin/python'} 15:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:28 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:23:28 INFO - Cleaning up... 15:23:28 INFO - Return code: 0 15:23:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:23: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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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', '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 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:23: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 psutil>=3.1.1 15:23:28 INFO - Using env: {'DISPLAY': ':0', 15:23:28 INFO - 'HOME': '/home/cltbld', 15:23:28 INFO - 'LANG': 'en_US.UTF-8', 15:23:28 INFO - 'LANGUAGE': 'en_US:en', 15:23:28 INFO - 'LOGNAME': 'cltbld', 15:23:28 INFO - 'MAIL': '/var/mail/cltbld', 15:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:28 INFO - 'MOZ_NO_REMOTE': '1', 15:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:28 INFO - 'NO_EM_RESTART': '1', 15:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:28 INFO - 'PWD': '/builds/slave/test', 15:23:28 INFO - 'SHELL': '/bin/bash', 15:23:28 INFO - 'SHLVL': '1', 15:23:28 INFO - 'TERM': 'linux', 15:23:28 INFO - 'TMOUT': '86400', 15:23:28 INFO - 'USER': 'cltbld', 15:23:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:28 INFO - '_': '/tools/buildbot/bin/python'} 15:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:29 INFO - Downloading/unpacking psutil>=3.1.1 15:23: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:23: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:23: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:23: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:23: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:23: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:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:31 INFO - Installing collected packages: psutil 15:23:31 INFO - Running setup.py install for psutil 15:23:31 INFO - building 'psutil._psutil_linux' extension 15:23:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:23:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:23:31 INFO - building 'psutil._psutil_posix' extension 15:23:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:23:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:31 INFO - Successfully installed psutil 15:23:31 INFO - Cleaning up... 15:23:31 INFO - Return code: 0 15:23:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:23:31 INFO - Using env: {'DISPLAY': ':0', 15:23:31 INFO - 'HOME': '/home/cltbld', 15:23:31 INFO - 'LANG': 'en_US.UTF-8', 15:23:31 INFO - 'LANGUAGE': 'en_US:en', 15:23:31 INFO - 'LOGNAME': 'cltbld', 15:23:31 INFO - 'MAIL': '/var/mail/cltbld', 15:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:31 INFO - 'MOZ_NO_REMOTE': '1', 15:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:31 INFO - 'NO_EM_RESTART': '1', 15:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:31 INFO - 'PWD': '/builds/slave/test', 15:23:31 INFO - 'SHELL': '/bin/bash', 15:23:31 INFO - 'SHLVL': '1', 15:23:31 INFO - 'TERM': 'linux', 15:23:31 INFO - 'TMOUT': '86400', 15:23:31 INFO - 'USER': 'cltbld', 15:23:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:31 INFO - '_': '/tools/buildbot/bin/python'} 15:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:23: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:23: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:23: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:23: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:23: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:23: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:23:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:23:33 INFO - Installing collected packages: mozsystemmonitor 15:23:33 INFO - Running setup.py install for mozsystemmonitor 15:23:33 INFO - Successfully installed mozsystemmonitor 15:23:33 INFO - Cleaning up... 15:23:33 INFO - Return code: 0 15:23:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:33 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 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:33 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:23:33 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:23:33 INFO - Using env: {'DISPLAY': ':0', 15:23:33 INFO - 'HOME': '/home/cltbld', 15:23:33 INFO - 'LANG': 'en_US.UTF-8', 15:23:33 INFO - 'LANGUAGE': 'en_US:en', 15:23:33 INFO - 'LOGNAME': 'cltbld', 15:23:33 INFO - 'MAIL': '/var/mail/cltbld', 15:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:33 INFO - 'MOZ_NO_REMOTE': '1', 15:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:33 INFO - 'NO_EM_RESTART': '1', 15:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:33 INFO - 'PWD': '/builds/slave/test', 15:23:33 INFO - 'SHELL': '/bin/bash', 15:23:33 INFO - 'SHLVL': '1', 15:23:33 INFO - 'TERM': 'linux', 15:23:33 INFO - 'TMOUT': '86400', 15:23:33 INFO - 'USER': 'cltbld', 15:23:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:33 INFO - '_': '/tools/buildbot/bin/python'} 15:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:23:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:23:35 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:23:35 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:23:35 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:23:35 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:23:35 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:23:35 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:23:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:23:36 INFO - warning: no files found matching '*.txt' 15:23:36 INFO - no previously-included directories found matching 'build' 15:23:36 INFO - no previously-included directories found matching 'dist' 15:23:36 INFO - no previously-included directories found matching '.git*' 15:23:36 INFO - Installing collected packages: jsonschema, functools32 15:23:36 INFO - Running setup.py install for functools32 15:23:36 INFO - warning: no files found matching '*.txt' 15:23:36 INFO - no previously-included directories found matching 'build' 15:23:36 INFO - no previously-included directories found matching 'dist' 15:23:36 INFO - no previously-included directories found matching '.git*' 15:23:36 INFO - Successfully installed jsonschema functools32 15:23:36 INFO - Cleaning up... 15:23:36 INFO - Return code: 0 15:23:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:23:36 INFO - Using env: {'DISPLAY': ':0', 15:23:36 INFO - 'HOME': '/home/cltbld', 15:23:36 INFO - 'LANG': 'en_US.UTF-8', 15:23:36 INFO - 'LANGUAGE': 'en_US:en', 15:23:36 INFO - 'LOGNAME': 'cltbld', 15:23:36 INFO - 'MAIL': '/var/mail/cltbld', 15:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:36 INFO - 'MOZ_NO_REMOTE': '1', 15:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:36 INFO - 'NO_EM_RESTART': '1', 15:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:36 INFO - 'PWD': '/builds/slave/test', 15:23:36 INFO - 'SHELL': '/bin/bash', 15:23:36 INFO - 'SHLVL': '1', 15:23:36 INFO - 'TERM': 'linux', 15:23:36 INFO - 'TMOUT': '86400', 15:23:36 INFO - 'USER': 'cltbld', 15:23:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:36 INFO - '_': '/tools/buildbot/bin/python'} 15:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:23:36 INFO - Cleaning up... 15:23:36 INFO - Return code: 0 15:23:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:23:36 INFO - Using env: {'DISPLAY': ':0', 15:23:36 INFO - 'HOME': '/home/cltbld', 15:23:36 INFO - 'LANG': 'en_US.UTF-8', 15:23:36 INFO - 'LANGUAGE': 'en_US:en', 15:23:36 INFO - 'LOGNAME': 'cltbld', 15:23:36 INFO - 'MAIL': '/var/mail/cltbld', 15:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:36 INFO - 'MOZ_NO_REMOTE': '1', 15:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:36 INFO - 'NO_EM_RESTART': '1', 15:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:36 INFO - 'PWD': '/builds/slave/test', 15:23:36 INFO - 'SHELL': '/bin/bash', 15:23:36 INFO - 'SHLVL': '1', 15:23:36 INFO - 'TERM': 'linux', 15:23:36 INFO - 'TMOUT': '86400', 15:23:36 INFO - 'USER': 'cltbld', 15:23:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:36 INFO - '_': '/tools/buildbot/bin/python'} 15:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:38 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:23:38 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:23:38 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:23:38 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:23:38 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:23:38 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:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:23:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:39 INFO - Downloading docopt-0.6.1.tar.gz 15:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:39 INFO - Running setup.py install for blobuploader 15:23:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:23:39 INFO - Running setup.py install for requests 15:23:39 INFO - Running setup.py install for docopt 15:23:40 INFO - Successfully installed blobuploader requests docopt 15:23:40 INFO - Cleaning up... 15:23:40 INFO - Return code: 0 15:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:23:40 INFO - Using env: {'DISPLAY': ':0', 15:23:40 INFO - 'HOME': '/home/cltbld', 15:23:40 INFO - 'LANG': 'en_US.UTF-8', 15:23:40 INFO - 'LANGUAGE': 'en_US:en', 15:23:40 INFO - 'LOGNAME': 'cltbld', 15:23:40 INFO - 'MAIL': '/var/mail/cltbld', 15:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:40 INFO - 'MOZ_NO_REMOTE': '1', 15:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:40 INFO - 'NO_EM_RESTART': '1', 15:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:40 INFO - 'PWD': '/builds/slave/test', 15:23:40 INFO - 'SHELL': '/bin/bash', 15:23:40 INFO - 'SHLVL': '1', 15:23:40 INFO - 'TERM': 'linux', 15:23:40 INFO - 'TMOUT': '86400', 15:23:40 INFO - 'USER': 'cltbld', 15:23:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:40 INFO - '_': '/tools/buildbot/bin/python'} 15:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:40 INFO - Running setup.py (path:/tmp/pip-5r3PUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:40 INFO - Running setup.py (path:/tmp/pip-gcetyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:40 INFO - Running setup.py (path:/tmp/pip-29Xk_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:40 INFO - Running setup.py (path:/tmp/pip-BpTnnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:40 INFO - Running setup.py (path:/tmp/pip-4YDR8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:40 INFO - Running setup.py (path:/tmp/pip-52e2i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:40 INFO - Running setup.py (path:/tmp/pip-vz7Ewo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:40 INFO - Running setup.py (path:/tmp/pip-8etfN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:40 INFO - Running setup.py (path:/tmp/pip-sMhZQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:41 INFO - Running setup.py (path:/tmp/pip-Tjnc6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:41 INFO - Running setup.py (path:/tmp/pip-nzGdNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:41 INFO - Running setup.py (path:/tmp/pip-naIdMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:41 INFO - Running setup.py (path:/tmp/pip-TsdTMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:41 INFO - Running setup.py (path:/tmp/pip-MLdNfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:41 INFO - Running setup.py (path:/tmp/pip-7bZBVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:41 INFO - Running setup.py (path:/tmp/pip-Jf8UNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:41 INFO - Running setup.py (path:/tmp/pip-5IxSvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:41 INFO - Running setup.py install for manifestparser 15:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:23:41 INFO - Running setup.py install for mozcrash 15:23:41 INFO - Running setup.py install for mozdebug 15:23:41 INFO - Running setup.py install for mozdevice 15:23:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozfile 15:23:42 INFO - Running setup.py install for mozhttpd 15:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozinfo 15:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozInstall 15:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozleak 15:23:42 INFO - Running setup.py install for mozlog 15:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for moznetwork 15:23:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozprocess 15:23:42 INFO - Running setup.py install for mozprofile 15:23:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:23:42 INFO - Running setup.py install for mozrunner 15:23:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:23:43 INFO - Running setup.py install for mozscreenshot 15:23:43 INFO - Running setup.py install for moztest 15:23:43 INFO - Running setup.py install for mozversion 15:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:43 INFO - Cleaning up... 15:23:43 INFO - Return code: 0 15:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:23:43 INFO - Using env: {'DISPLAY': ':0', 15:23:43 INFO - 'HOME': '/home/cltbld', 15:23:43 INFO - 'LANG': 'en_US.UTF-8', 15:23:43 INFO - 'LANGUAGE': 'en_US:en', 15:23:43 INFO - 'LOGNAME': 'cltbld', 15:23:43 INFO - 'MAIL': '/var/mail/cltbld', 15:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:43 INFO - 'MOZ_NO_REMOTE': '1', 15:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:43 INFO - 'NO_EM_RESTART': '1', 15:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:43 INFO - 'PWD': '/builds/slave/test', 15:23:43 INFO - 'SHELL': '/bin/bash', 15:23:43 INFO - 'SHLVL': '1', 15:23:43 INFO - 'TERM': 'linux', 15:23:43 INFO - 'TMOUT': '86400', 15:23:43 INFO - 'USER': 'cltbld', 15:23:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:43 INFO - '_': '/tools/buildbot/bin/python'} 15:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:43 INFO - Running setup.py (path:/tmp/pip-y1nxRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:43 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:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:43 INFO - Running setup.py (path:/tmp/pip-pWLlOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:43 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:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:43 INFO - Running setup.py (path:/tmp/pip-VQGt1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:43 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:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:43 INFO - Running setup.py (path:/tmp/pip-wKU_N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:43 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:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:43 INFO - Running setup.py (path:/tmp/pip-0xUWn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:43 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:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:43 INFO - Running setup.py (path:/tmp/pip-BTcEaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:44 INFO - Running setup.py (path:/tmp/pip-0tO0Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:44 INFO - Running setup.py (path:/tmp/pip-cIaJYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:44 INFO - Running setup.py (path:/tmp/pip-uC8KzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:44 INFO - Running setup.py (path:/tmp/pip-xD1Uhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:44 INFO - Running setup.py (path:/tmp/pip-60D0tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:44 INFO - Running setup.py (path:/tmp/pip-K9KNTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:44 INFO - Running setup.py (path:/tmp/pip-H1MxMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:44 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:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:44 INFO - Running setup.py (path:/tmp/pip-lFOzZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:44 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:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:44 INFO - Running setup.py (path:/tmp/pip-pGCWC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:44 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:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:44 INFO - Running setup.py (path:/tmp/pip-k5DSDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:44 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:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:44 INFO - Running setup.py (path:/tmp/pip-UclhEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:44 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:23:44 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:23:44 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:23:44 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:23:44 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:23:44 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:23:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:46 INFO - Downloading blessings-1.6.tar.gz 15:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:23:46 INFO - Installing collected packages: blessings 15:23:46 INFO - Running setup.py install for blessings 15:23:46 INFO - Successfully installed blessings 15:23:46 INFO - Cleaning up... 15:23:46 INFO - Return code: 0 15:23:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:23:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:47 INFO - Reading from file tmpfile_stdout 15:23:47 INFO - Current package versions: 15:23:47 INFO - argparse == 1.2.1 15:23:47 INFO - blessings == 1.6 15:23:47 INFO - blobuploader == 1.2.4 15:23:47 INFO - docopt == 0.6.1 15:23:47 INFO - functools32 == 3.2.3-2 15:23:47 INFO - jsonschema == 2.5.1 15:23:47 INFO - manifestparser == 1.1 15:23:47 INFO - mozInstall == 1.12 15:23:47 INFO - mozcrash == 0.17 15:23:47 INFO - mozdebug == 0.1 15:23:47 INFO - mozdevice == 0.48 15:23:47 INFO - mozfile == 1.2 15:23:47 INFO - mozhttpd == 0.7 15:23:47 INFO - mozinfo == 0.9 15:23:47 INFO - mozleak == 0.1 15:23:47 INFO - mozlog == 3.3 15:23:47 INFO - moznetwork == 0.27 15:23:47 INFO - mozprocess == 0.23 15:23:47 INFO - mozprofile == 0.28 15:23:47 INFO - mozrunner == 6.12 15:23:47 INFO - mozscreenshot == 0.1 15:23:47 INFO - mozsystemmonitor == 0.3 15:23:47 INFO - moztest == 0.7 15:23:47 INFO - mozversion == 1.4 15:23:47 INFO - psutil == 3.1.1 15:23:47 INFO - requests == 1.2.3 15:23:47 INFO - wsgiref == 0.1.2 15:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:23:47 INFO - Using env: {'DISPLAY': ':0', 15:23:47 INFO - 'HOME': '/home/cltbld', 15:23:47 INFO - 'LANG': 'en_US.UTF-8', 15:23:47 INFO - 'LANGUAGE': 'en_US:en', 15:23:47 INFO - 'LOGNAME': 'cltbld', 15:23:47 INFO - 'MAIL': '/var/mail/cltbld', 15:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:47 INFO - 'MOZ_NO_REMOTE': '1', 15:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:47 INFO - 'NO_EM_RESTART': '1', 15:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:47 INFO - 'PWD': '/builds/slave/test', 15:23:47 INFO - 'SHELL': '/bin/bash', 15:23:47 INFO - 'SHLVL': '1', 15:23:47 INFO - 'TERM': 'linux', 15:23:47 INFO - 'TMOUT': '86400', 15:23:47 INFO - 'USER': 'cltbld', 15:23:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:47 INFO - '_': '/tools/buildbot/bin/python'} 15:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:23:47 INFO - Cleaning up... 15:23:47 INFO - Return code: 0 15:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2999030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, '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': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', '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:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:23:47 INFO - Using env: {'DISPLAY': ':0', 15:23:47 INFO - 'HOME': '/home/cltbld', 15:23:47 INFO - 'LANG': 'en_US.UTF-8', 15:23:47 INFO - 'LANGUAGE': 'en_US:en', 15:23:47 INFO - 'LOGNAME': 'cltbld', 15:23:47 INFO - 'MAIL': '/var/mail/cltbld', 15:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:47 INFO - 'MOZ_NO_REMOTE': '1', 15:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:47 INFO - 'NO_EM_RESTART': '1', 15:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:47 INFO - 'PWD': '/builds/slave/test', 15:23:47 INFO - 'SHELL': '/bin/bash', 15:23:47 INFO - 'SHLVL': '1', 15:23:47 INFO - 'TERM': 'linux', 15:23:47 INFO - 'TMOUT': '86400', 15:23:47 INFO - 'USER': 'cltbld', 15:23:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:47 INFO - '_': '/tools/buildbot/bin/python'} 15:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:23:47 INFO - Cleaning up... 15:23:47 INFO - Return code: 0 15:23:47 INFO - Running post-action listener: _resource_record_post_action 15:23:47 INFO - Running post-action listener: _start_resource_monitoring 15:23:47 INFO - Starting resource monitoring. 15:23:47 INFO - [mozharness: 2016-08-03 22:23:47.632215Z] Finished create-virtualenv step (success) 15:23:47 INFO - [mozharness: 2016-08-03 22:23:47.632734Z] Running install step. 15:23:47 INFO - Running pre-action listener: _resource_record_pre_action 15:23:47 INFO - Running main action method: install 15:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:47 INFO - Reading from file tmpfile_stdout 15:23:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:23:47 INFO - Reading from file tmpfile_stdout 15:23:47 INFO - Output received: 15:23:47 INFO - Usage: mozinstall [options] installer 15:23:47 INFO - Options: 15:23:47 INFO - -h, --help show this help message and exit 15:23:47 INFO - -d DEST, --destination=DEST 15:23:47 INFO - Directory to install application into. [default: 15:23:47 INFO - "/builds/slave/test"] 15:23:47 INFO - --app=APP Application being installed. [default: firefox] 15:23:47 INFO - mkdir: /builds/slave/test/build/application 15:23:47 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:23:47 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:24:04 INFO - Reading from file tmpfile_stdout 15:24:04 INFO - Output received: 15:24:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:24:04 INFO - Running post-action listener: _resource_record_post_action 15:24:04 INFO - [mozharness: 2016-08-03 22:24:04.134589Z] Finished install step (success) 15:24:04 INFO - [mozharness: 2016-08-03 22:24:04.134868Z] Running run-tests step. 15:24:04 INFO - Running pre-action listener: _resource_record_pre_action 15:24:04 INFO - Running main action method: run_tests 15:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:04 INFO - Python 2.7.3 15:24:04 INFO - Return code: 0 15:24:04 INFO - grabbing minidump binary from tooltool 15:24: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:24:04 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 0x2c583b0>, '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 0x2c592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:04 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:24:04 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:24:04 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:24:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:04 INFO - Return code: 0 15:24:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:24:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:24:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:24:04 INFO - Using env: {'DISPLAY': ':0', 15:24:04 INFO - 'HOME': '/home/cltbld', 15:24:04 INFO - 'LANG': 'en_US.UTF-8', 15:24:04 INFO - 'LANGUAGE': 'en_US:en', 15:24:04 INFO - 'LOGNAME': 'cltbld', 15:24:04 INFO - 'MAIL': '/var/mail/cltbld', 15:24:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:04 INFO - 'MOZ_NO_REMOTE': '1', 15:24:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:04 INFO - 'NO_EM_RESTART': '1', 15:24:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:04 INFO - 'PWD': '/builds/slave/test', 15:24:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:04 INFO - 'SHELL': '/bin/bash', 15:24:04 INFO - 'SHLVL': '1', 15:24:04 INFO - 'TERM': 'linux', 15:24:04 INFO - 'TMOUT': '86400', 15:24:04 INFO - 'USER': 'cltbld', 15:24:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089', 15:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:04 INFO - '_': '/tools/buildbot/bin/python'} 15:24:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:24:04 INFO - mozversion application_buildid: 20160803140449 15:24:04 INFO - mozversion application_changeset: de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a 15:24:04 INFO - mozversion application_display_name: Nightly 15:24:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:04 INFO - mozversion application_name: Firefox 15:24:04 INFO - mozversion application_remotingname: firefox 15:24:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:24:04 INFO - mozversion application_vendor: Mozilla 15:24:04 INFO - mozversion application_version: 51.0a1 15:24:04 INFO - mozversion platform_buildid: 20160803140449 15:24:04 INFO - mozversion platform_changeset: de6fd5bb93d26985b6b7eb8b1e2ec896b8e7611a 15:24:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:24:04 INFO - mozversion platform_version: 51.0a1 15:24:04 INFO - using testdate: 1470263044 15:24:04 INFO - actual date: 1470263044 15:24:04 INFO - starting webserver on 'localhost:39125' 15:24:04 INFO - SUITE-START | Running 2 tests 15:24:04 INFO - TEST-START | dromaeo_css 15:24:04 INFO - operating with platform_type : linux_ 15:24:04 INFO - Initialising browser for dromaeo_css test... 15:24:04 INFO - TEST-INFO | started process 12006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9dG1q/profile http://localhost:39125/getInfo.html) 15:24:08 INFO - PROCESS | 12006 | __metrics Screen width/height:1600/1200 15:24:08 INFO - PROCESS | 12006 | colorDepth:24 15:24:08 INFO - PROCESS | 12006 | Browser inner width/height: 1024/697 15:24:08 INFO - PROCESS | 12006 | __metrics 15:24:09 INFO - PROCESS | 12006 | 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:24:09 INFO - PROCESS | 12006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:10 INFO - TEST-INFO | 12006: exit 0 15:24:10 INFO - Browser initialized. 15:24:10 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:10 INFO - TEST-INFO | started process 12085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9dG1q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:22 INFO - PROCESS | 12085 | RSS: Main: 157900800 15:24:22 INFO - PROCESS | 12085 | 15:25:13 INFO - PROCESS | 12085 | 1470263113812 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:27:27 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39125/tests/dromaeo/cssquery-ext.html) 15:27:28 INFO - PROCESS | 12085 | RSS: Main: 247730176 15:27:28 INFO - PROCESS | 12085 | 15:30:31 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-ext.html (next: http://localhost:39125/tests/dromaeo/cssquery-jquery.html) 15:30:31 INFO - PROCESS | 12085 | RSS: Main: 251842560 15:30:31 INFO - PROCESS | 12085 | 15:33:33 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39125/tests/dromaeo/cssquery-mootools.html) 15:33:34 INFO - PROCESS | 12085 | RSS: Main: 189988864 15:33:34 INFO - PROCESS | 12085 | 15:36:36 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39125/tests/dromaeo/cssquery-prototype.html) 15:36:37 INFO - PROCESS | 12085 | RSS: Main: 188923904 15:36:37 INFO - PROCESS | 12085 | 15:39:40 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39125/tests/dromaeo/cssquery-yui.html) 15:39:40 INFO - PROCESS | 12085 | RSS: Main: 189706240 15:39:40 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-yui.html (next: http://localhost:39125/tests/dromaeo/cssquery-dojo.html) 15:42:43 INFO - PROCESS | 12085 | RSS: Main: 279752704 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | __start_tp_report 15:42:43 INFO - PROCESS | 12085 | _x_x_mozilla_page_load 15:42:43 INFO - PROCESS | 12085 | _x_x_mozilla_page_load_details 15:42:43 INFO - PROCESS | 12085 | |i|pagename|runs| 15:42:43 INFO - PROCESS | 12085 | |0;dojo.html;2689.3007817967323;2689.421774318522;2723.822951508151;2731.289864635194;2735.4665840161165;4658.347831303612;4701.2478003519445;4850.951490485094;4906.0433215523035;4919.385076865392;4712.3873896393425;4861.73260470674;4868.56182943535;4914.97542512287;4964.503549645034;4393.011572396217;4447.799849006787;4492.573205545468;4526.185286648402;4603.470600880892;4535.659825513099;4587.311903214528;4597.103564804865;4619.769011549426;4633.49031606523;4338.2191205582985;4527.615152712024;4539.024109816405;4585.5185205553435;4640.883977900546;4369.694121411502;4416.911661766747;4427.734335939822;4479.574440428187;4494.483134439549;4395.208862404766;4398.076403955141;4434.1131773645075;4437.33439984005;4451.354553589711;4856.271559266103;4868.075065737534;4893.486183950669;4917.655764096515;4931.235658472942;5024.497550244946;5082.669626474268;5176.611754118456;5180.974095129538;5262.368515778093;5241.50205730455;5262.789488420459;5276.366835979668;5289;5293.655912365684;4700.858974230779;4869.14789911764;4870.269459581091;4903.41159060915;4907.484714105039;5275.155975043975;5319.494648008433;5329.8934021319355;5330.866728331745;5424.321959755031;5127.820526281562;5173.81891633791;5174.741262936914;5179.81870634526;5180;4972.378452693413;5217.165253559412;5219.895602087937;5269.420363759983;5285.392179899284;5145.639805213674;5191.740412979336;5199.948000520022;5228.058949389147;5295.391030031518;5208.817691380784;5211.166213405837;5213.582913366921;5223.2948551945765;5264.184051472028;4099.3031184698675;4381.014271788822;4387.166438376698;4400.779961002001;4431.357453169272;3631.94552081719;3750.568684601306;3765.7175711821724;3825.6365645263654;3902.726809123334;4445;4452.354408610733;4453.799579018952;4477.70894891831;4497.887552811206;5169.689818610896;5180.948190518122;5181.948180518222;5190.299309593157;5195.19474481456;4334.934975975363;4404.911901761947;4435.246008178618;4438.245498265303;4512.932306015412;4620.607248383858;4631.235846085358;4643.094596553708;4648.825604362251;4695.694779839299;4840.104580652591;4874.2444921037295;4886.486918873609;4896.755162241945;4961.454240033666;5039.294498770102;5116.720819795051;5161.8451446455165;5163.199704045879;5298.70857102863;4874.098291816025;4884;4902.5587697106;4911.459739428588;4954.405471343318;5168.819091331786;5175.81884634036;5184.818531351385;5185.559227465707;5194.065068287593;5034.899302013866;5110.131277682728;5155.948440515697;5164.896702065863;5242.213667949838;5015.473375295687;5025.070361983045;5041.067402530543;5042.773075211551;5078.415982162099;5016.097102521581;5026.195808670595;5027.145385284583;5030;5051.419086805065;4808.663393562417;4909.533594308535;4963.851084467472;4976.601871850316;5037.571806396498;5078.365204349457;5087.08432482142;5088.313077734459;5090.592752579859;5136.640435169502;4939.086269040239;4978.975105124451;4980.526849949249;4982.227754698028;4983.227599722049 15:42:43 INFO - PROCESS | 12085 | |1;ext.html;576.6482445708117;584.2113147251209;592.0674936974264;592.2803793391029;597;29793.702062979362;39253.01867453315;40924.97687557809;40928.38607420884;45074.32388514175;41983.370249446285;42359.15281694364;42368.576314236845;42380;42582;7696.769096927087;7836.764897053097;7852.685892564291;7871.921280787176;7884.448088633798;7686.846263074735;7759.689612415496;7780.649870755829;7796.727114550963;7801.063872335328;7804.336631386339;7856.803579910491;7859.096203936563;7862.567558784264;7864.370850331989;7731.188225236354;7768.184340644264;7795.259450352208;7796.883046754303;7814.882776758353;7737.535747855147;7801.531908085476;7814.413918956101;7814.531128132274;7820.061592608867;39611.40582891259;39844;39928;39971.600283997075;39982.800085999676;3130.280035591804;3137.7332926701256;3529.347070791886;3742.4760533525327;3844.730868839182;30176.651343934685;30879.691203087907;31008.8449557753;31237.37525249505;33692.49461258083;3280.622728386242;3378.6735504368644;3395.2360718838063;3406.7104296134858;3547.396942519752;257751;261344;262473;262846;263486;58292.417075829544;59516;59583.404165957785;59595.40404595899;59645.10532342018;34327.313453730785;34977.82511087479;35149.472757908654;37294.62705372966;62428.68785656134;14042.438302467786;14113.576592702235;14120.505782297776;14137.78793318101;14150.504732334524;10121.595136194617;10129.696109116738;10130.037646423578;10154.289199756095;10165.034321739422;19683;19732;19821;19942.60114797725;20040.49898752543;7156.964215178995;7389.593572353572;7512.21121782205;7528.924710752932;7551.73568925085;807.4428644235459;823.5635113389912;979.7844474215661;982.4645568165367;982.8722266105503;28461.288467788472;28784.280392990342;28983.85508072446;29473.557896631566;29544.704552954194;762.9160792312841;979.4368238262884;980.5342462330478;1007.2294694558668;1019.3628981886321;13995.720085598232;15038.248087595577;15062.322195501229;15251.313690883937;15525.223738813014;409820;410644;413342;413387;414338;52113.73943130336;52510.73744631252;52620.473795262325;52658.21012684813;52744.73627631837;1086.1039642295138;1121.315997241682;1151.4760783843499;1185.1170877696172;1210.4734440518403;27251;29652.406951860412;30107.69892301049;30838.383232335676;30867.536986944764;44049.339259911765;44544.55455445534;44640.55359446364;44651.553484466036;44685.55314446814;249702;250824;251060;251067;251434;25771.226863194133;26768.866155669097;26784;26833.597496037186;26865.731342686322;42997.785011076;43219.78390108029;43421.818923937106;44235;44406;36770.448443272835;37133.25733485369;37390.25219495541;38139.42790858084;38168.42747358736;36667;36794.448083279305;37011.6298837019;37234;37711.434328485644;36349.636503634625;36584.26831463409;36969.81515092515;37001.44497832588;37797;31495.527567086054;33940;34039.829800851825;34061.31877362489;34276.48585271273;25586.360340991625;25656.871715641304;25743;25927.481450371266;26059.21822345333 15:42:43 INFO - PROCESS | 12085 | |2;jquery.html;340.2672680692799;363.53830635093414;371.20006386237657;375.4837098988891;388.39410519589444;13040.282784446852;16417.34330626775;16957.576060598476;18114.818851811477;18417.07914604271;16976.915115424435;16987.83012169878;17050.48848534546;17105.144742762845;17247.82752172478;5016.69899806011;5107.923381149286;5357.785688572472;5384.326959130109;5435.701036442994;3464.861405543788;5396.78412863485;5421.21392398102;5427.538659213971;5674.517665998395;5967.761289548413;6003.219581454405;6023.6988150592515;6035;6041.093835924625;5838.065909454509;5885.234919460464;5928.466438020556;5939.4357536034;6000.3699611540815;5291.682499050069;5299.54953828925;5300.946990530122;5304.6286759926825;5305.681659100428;12726.68183295425;20733.68899466509;21050.78949210519;21142.682859757115;21211.045502952406;1811.0854018720593;1842.7512285841374;1866.038989920192;1892.1579896945864;1904.9619007619908;8794.384393092487;9280.211182049534;9287.442753434749;9637.807243855154;12781.744365112645;1743.128435782109;1804.9729254061199;1841.5764374194011;1850.685383484811;1875.7936626971023;66400;68010.65994670044;69452.6527367365;71560;72270.63864680695;9875.259355548362;10039.146672532917;10167.949160254151;10205.132563732017;10241.74395640115;14012.579622611338;14036.859631403759;14047.016708830284;14050.648733781532;14083.788743168861;6945.93054069463;7056.54132481387;7174.784756457315;7207.89188162178;7219.711211551479;6504.317046710122;6612.7354905804195;6615.66921653925;6790.32096790317;6798.966005170041;4328.718633288826;4375.956240437618;4389.100234451929;4424.6239069678795;4493.775311234425;1793.847522960563;1839.3010655950652;1852.4905650945827;1863.3292014874635;1864.0613761687964;812.9674813007414;822.0258993093084;866.5927014303268;903.4985583001497;961.4711908450324;16445.83554164467;16466;17313.480595582154;17628.618479791996;17754.467365979042;852.4331319672349;858.3090612057229;872.9912700873037;885.5085427587621;925.5511077127587;9419.15227629503;9684.95157524208;9935.354201976848;9969.501524923724;10101.69694909154;377051;395418;404011;404711;405125;70170;73473;73553;74062;76740.61629691928;892.5314210039782;898.3576742629182;923.2660035271975;926.7497775600685;928.4150984879483;15375.846241537442;15450.84549154494;15616.297266623256;16188.433404830774;16207.837921620632;34987.82506087453;35471.64528354684;36380.454293185096;36559.81720091382;37525.4371184427;48042.5195748038;50166.74916625393;50201.74899125481;50714.74642626763;51402.97194056173;6484.221893372825;6914.274001229798;7034.648267586498;7049.541779784297;8051.194880511902;10113.949430252802;11952.880471195176;12099.395030248277;12313.076519260912;12352.25886446816;9614.18279446255;9762.219022478326;9774.364666296668;9856.359336643096;10095.293329466867;10238.385696858213;10373.066424021874;10431.16550675929;10495.947520262349;10536.736581585521;6795.830104247433;7629.122650894996;9707.805843882941;9936.168192065516;10258;10758.193135514712;10965;11091.44542772842;11360.886391135982;11804.940975295069;10589.576416943237;10696.03735663794;10699.197560182862;10864.402457864893;11338.206325557132 15:42:43 INFO - PROCESS | 12085 | |3;mootools.html;1260.6281147061616;1329.5545992092648;1388.4307433952079;1435.7272118297524;1678.5384019394673;6504.219493660761;7143.678534465948;7499.9875016872775;7503.362214211798;7722.420818438625;7487.475876688621;7487.700491980314;7504.061992250969;7537.095548534184;7557.848843023136;2172.880491572967;2195.495036141688;2201.3946164804647;2204.3166618348364;2204.4488877780555;2150.935287032913;2198.0218802632835;2202.493426511903;2209.4807720185745;2212.83403744719;2082.458560774202;2089.529855782452;2097.1192099318246;2106.8314534837177;2130.3928380411585;2087.8642888212294;2094.7276854009033;2095.182878677317;2095.6961240620176;2097.213544920655;2065.2461851424273;2124.5326028273753;2126.032655141922;2126.861753985986;2131.1794958940764;7360.153582337993;7413.369863561604;7551.584662843541;7587.165411804697;7595.582242976634;4234.87295381139;4414;4419.0940857124215;4419.889502762425;4434.977825110854;2792.581112833071;2899.449104670106;2919.459899918522;2922.970770292291;2930.9413811723857;910.2172131966504;911.6080085563206;928.6285485805664;932.1936524905908;936.892257390402;10120.493975301206;10215.591376344937;10263.486825658762;10275.229357798195;10275.486225688686;3683.244934788362;3810.8285127169343;3932.5870783567884;3961.504811898513;3979;8141.389395795339;8160;8164.510129392255;8192;8203.30271926881;4300.182965236595;4304.031592891574;4304.225239456928;4312.029793296483;4312.37470566766;3487.7035451986358;3800.7909564974193;3944.2111577684577;3993.381025940984;3995.420664003703;3345.815980121068;3375.4430518964587;3482.89551313461;3491.17957280039;3491.6857482826667;1018.2261481274137;1026.1226651213105;1028.8148133335922;1068.9144868410508;1069.3851035654375;673.9932600674028;723.9565626062453;762.7139822566537;810.7527204202656;827.7020272701823;4855.635827312895;4896.069746748107;4935.728534930613;5156.948430515722;5348.465153484698;370.0286747288368;370.98535505392726;375.3337825360008;392.40942381715337;406.0761766980085;3266.530061472347;3440.535527703778;3459.636738142459;3477.7739446935866;3571.821408929543;8582.87125693115;9302.348835581444;9368.67209647659;9379.390339627902;9420;9350.766230844147;9350.812983740287;9351.111644393772;9354.672586459441;9356.859647105299;6987.510874238857;7196.244394338519;7235.63821808897;7238.92761072393;7242.529235599669;5005.899882002267;5043.2435134730085;5122.871928201825;5125.820596279113;5137.537621614073;8293.543855087786;8609;8617.87073193915;8689.0876457971;8712.477251364939;8620.655173792979;8757.47455152693;8871.64513419456;8911.73264802057;8936.910630893608;5776.104703770922;6331.050342448485;6500.5449618526245;6639.535232533676;6647.302033286435;7021.368076873106;7119.928800711927;7259.564426134449;7262;7271.745488907863;6398.712057957497;6403.263624683034;6455.515836312389;6495.9025614614875;6659.500537459613;6436.388543088399;6478.870422591616;6487.513436492188;6489.610623362613;6508.576942498722;6288.27684816252;6398.5521013528605;6406.647634380154;6409.487241020801;6419.422251997343;4267.274563324305;4336.39290499324;4441;4489.259272220178;4510.50384457716;4235.682323825787;4256.106217694195;4563.406757121553;4584;4652.55800698933 15:42:43 INFO - PROCESS | 12085 | |4;prototype.html;287.2961244949873;287.9697631748666;290.3612053482337;291.77824853111645;293.0446743615812;4867.3915760529935;4889.902201955959;4893.755312234387;4893.8287159949405;4916.532929371713;4772.451168115667;4794.496577859327;4808.54764070324;4823.78292976816;4861.756912154387;3603.117236277116;3691.335559599271;3694.8152592370407;3760.4359346098167;3805.771653700787;3781.3193625147464;3783.602721714222;3790.2040571480024;3809.8285577149095;3814.8555433370016;3709.4250391189275;3726.6646001859826;3735.2902948439846;3775.754575952568;3782.8108594570162;3603.873864414746;3639.363111455498;3741.681957033655;3757.6993840492696;3758.5489741230954;3335.5997280326274;3337.9833100834585;3354.480055591387;3356.1038013522284;3361.5798025246845;4687.929681054787;4724.574788269072;4751.121042607128;4768.73771942543;4793.400824896888;4234.894127646803;4326.502452218004;4348.456442944632;4373.234683930331;4383.298672212462;5029.4216165141115;5030.647854650176;5040.395152581677;5042.924356134624;5042.991401719671;3636.672699457035;3643.3806252936797;3646.762960407565;3647.4467872489363;3675.1547144156993;5145.897082058375;5332.226827110087;5345.797195630952;5373.5163835254625;5374.865628359284;3704.555453345562;3716.1638631307737;3723.8696645617274;3743.344914639927;3744.475773391727;3771.7935008020613;3780.3762379207674;3784.2942296258307;3799.7720136791327;3807.790571518593;4296.174125996439;4323.027318853233;4324.372965919924;4332.956670433318;4341.175176716414;4844.95155048452;4990.3762029746285;5015.84635533822;5017.397912250553;5040.546350828443;1285.5152299094561;1293.5149319005372;1297.6172029251393;1301.9218846869219;1303.1855090568395;845.3152946113668;848.3510114762212;868.4108082209541;870.3428911172151;889.888763904512;4382.386465894777;4411.852918241216;4416.580424859633;4420.359047938031;4430.424044874146;5129.743512824344;5132.769025393866;5150.639455238097;5154.613403994716;5169.68981861082;4278.593533614302;4407.933880991788;4411.845585404495;4414.359917811899;4435.423394958635;2714.7013828478853;2718.9803823566162;2731.085086496006;2736.53478908586;2737.7809775217934;4805.735684537384;4819.204831202883;4829.227323628203;4833.516648335139;4886.218205087169;5103.617228707862;5241.292425522505;5278.868028299324;5289.487493440662;5291;4806.327114204014;4813.663043586916;4817.710937343771;4822.445418776885;4824.927626085611;5050.419201791841;5086.364204474441;5095;5096.165380462956;5125.103106956193;4890.133992662267;4942.184539550934;4964.751762411793;5029.823956161516;5057.089723849743;4790.496997815179;4791.329213909986;4797;4810.302506136521;4824.903501930012;3698.63013698628;3707.1473561081643;3709;3743.1016556026902;3758.5489741231227;5012.924806127838;5116.667416617908;5158.303629010035;5172.586193104467;5177.792888284426;4934.802607895644;4950.430700469492;4962.851114466572;5025.824096156617;5028.446870844277;4961.578265847299;4966.8758281043265;4971.751412429292;4984.728894131973;4990.6007519397635;4662.580367766917;4847.612191024639;4884.413870335582;4900.338454308623;4908.9263661045825;4768.809247630056;4845.830395936126;4949.307097006494;4950.970102258057;5011.949880501148;4891.29076283944;4900.681455705368;4902.289168070539;4913.410390753133;4924.532169443897 15:42:43 INFO - PROCESS | 12085 | |5;yui.html;640.9839754006149;641.397086738466;652.6954733532352;667.0461240426189;746.6416120262274;12157.817632735516;12812.782785635362;12815.487380504781;12843.486260549591;12852;12913.289769062698;12916.870831291684;12922.353882305893;12923.870761292384;12997.61007169784;611.626907586372;743.9925600744004;766.4251811141644;783.7805414483925;785.2853902948318;770.4106358635648;777.7472321495509;779.3336697123963;780.2236774409442;780.9687612495493;823.9464434811748;826.0335407573153;827.0447632983913;827.6192951242435;827.9461834980738;652.0935899100255;793.1196372027046;814.7433558429105;815.514768712615;821.5645707774829;607.4745345276305;607.5200591532683;607.5443417436923;607.872346807171;608.4007252855934;12773.74452510954;12774.105812593121;12800.743985120245;12814.42335094923;12817.935910320482;12409.875901240963;12657.93671031639;13004.544840930617;13312.068155229137;13412.731745365136;11200.770686119244;11348.375839328834;11588.072954163647;11635.476403561861;12113.878861211364;4087.1008378156757;4107.096438783463;4113.382992551112;4189.371594260855;4230.450041494617;67301.32698673049;67346.66326668335;67404.3259567403;67432.662836686;67468.32531674669;10029.348092373972;10161.237907156992;10333.793324133625;10459.215558833119;10501.842472362921;19451.708224376645;19470.902645486964;19488.805111948983;19582.90208548948;19601.411957641292;6715.966420167868;6765.661716914135;6771.492138089565;6778.593284402951;6818.420434263143;3779.8110094495164;3816.0650640592676;3819.4079917612817;3867.245887052054;3882.902927426837;2679.9464010720067;2794.0639885638134;2795.4269374778123;2796.24501384625;2796.454691335211;475.30130707859394;479.6115146731089;481.7543053042903;491.33669546113174;496.76900241387926;434.2595874034763;445.4409715806642;458.8187665871962;533.7011273686747;540.2436588775745;7801.29788319054;7862.685492580347;8057.6374063167295;8125.1062383137805;8130.796730081795;487.30802260789056;489.7649128418308;498.5637567128762;535.3067777228498;642.1042645509488;3678.6505281998166;3922.4620382935605;4122.928038709957;4305.461817272841;4397.73613583186;90249;90734.54632726795;91197.54401227951;93454;93881;82969.02185868747;83252.58373708093;83327;84087.57956210303;84878.57560712157;60164.69917650471;66381.66809165923;68905.3109468909;70568.29431705618;71334;7537.2462753724185;7623.123340815877;7653.464257501922;7947.682092716226;7956.880646790187;41882.37176442417;42124;42892.78553607212;43631.12737745291;44130.77934610435;54600.63498412572;55959.72020140036;63877.36122638714;65004.67497662482;65975.34024659693;10048.547815348473;10255.794884102126;10509.894901050891;10640;10749.193810464403;11017.504212310305;11109.611163609236;11485.942570287096;11829.940850295694;11831.230969987268;9867.06262905023;10040.949795250977;10666.200034997251;10796.406197659204;10890.782184356427;10569.101626361538;10746.355218686904;10823.56705731762;11083.445827708743;12956.093073484766;11468.770624587294;11627.825582616098;11922.344271065174;12256.080793940668;12281.385930703607;9893.703188904345;10059.647912323033;10129.493525323556;10375.844362334721;10415.53130109162;9963.957388735436;10046.447445390282;10130.8480372793;10137.64518241858;10157.644482443078 15:42:43 INFO - PROCESS | 12085 | __end_tp_report 15:42:43 INFO - PROCESS | 12085 | __start_cc_report 15:42:43 INFO - PROCESS | 12085 | _x_x_mozilla_cycle_collect,1013 15:42:43 INFO - PROCESS | 12085 | __end_cc_report 15:42:43 INFO - PROCESS | 12085 | __startTimestamp1470264163938__endTimestamp 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | ------- Summary: start ------- 15:42:43 INFO - PROCESS | 12085 | Number of tests: 6 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#0] dojo.html Cycles:165 Average:4798.39 Median:4919.39 stddev:511.49 (10.4%) stddev-sans-first:485.57 15:42:43 INFO - PROCESS | 12085 | Values: 2689.3 2689.4 2723.8 2731.3 2735.5 4658.3 4701.2 4851.0 4906.0 4919.4 4712.4 4861.7 4868.6 4915.0 4964.5 4393.0 4447.8 4492.6 4526.2 4603.5 4535.7 4587.3 4597.1 4619.8 4633.5 4338.2 4527.6 4539.0 4585.5 4640.9 4369.7 4416.9 4427.7 4479.6 4494.5 4395.2 4398.1 4434.1 4437.3 4451.4 4856.3 4868.1 4893.5 4917.7 4931.2 5024.5 5082.7 5176.6 5181.0 5262.4 5241.5 5262.8 5276.4 5289.0 5293.7 4700.9 4869.1 4870.3 4903.4 4907.5 5275.2 5319.5 5329.9 5330.9 5424.3 5127.8 5173.8 5174.7 5179.8 5180.0 4972.4 5217.2 5219.9 5269.4 5285.4 5145.6 5191.7 5199.9 5228.1 5295.4 5208.8 5211.2 5213.6 5223.3 5264.2 4099.3 4381.0 4387.2 4400.8 4431.4 3631.9 3750.6 3765.7 3825.6 3902.7 4445.0 4452.4 4453.8 4477.7 4497.9 5169.7 5180.9 5181.9 5190.3 5195.2 4334.9 4404.9 4435.2 4438.2 4512.9 4620.6 4631.2 4643.1 4648.8 4695.7 4840.1 4874.2 4886.5 4896.8 4961.5 5039.3 5116.7 5161.8 5163.2 5298.7 4874.1 4884.0 4902.6 4911.5 4954.4 5168.8 5175.8 5184.8 5185.6 5194.1 5034.9 5110.1 5155.9 5164.9 5242.2 5015.5 5025.1 5041.1 5042.8 5078.4 5016.1 5026.2 5027.1 5030.0 5051.4 4808.7 4909.5 4963.9 4976.6 5037.6 5078.4 5087.1 5088.3 5090.6 5136.6 4939.1 4979.0 4980.5 4982.2 4983.2 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#1] ext.html Cycles:180 Average:46962.93 Median:20566.36 stddev:83483.67 (405.9%) stddev-sans-first:83645.22 15:42:43 INFO - PROCESS | 12085 | Values: 576.6 584.2 592.1 592.3 597.0 29793.7 39253.0 40925.0 40928.4 45074.3 41983.4 42359.2 42368.6 42380.0 42582.0 7696.8 7836.8 7852.7 7871.9 7884.4 7686.8 7759.7 7780.6 7796.7 7801.1 7804.3 7856.8 7859.1 7862.6 7864.4 7731.2 7768.2 7795.3 7796.9 7814.9 7737.5 7801.5 7814.4 7814.5 7820.1 39611.4 39844.0 39928.0 39971.6 39982.8 3130.3 3137.7 3529.3 3742.5 3844.7 30176.7 30879.7 31008.8 31237.4 33692.5 3280.6 3378.7 3395.2 3406.7 3547.4 257751.0 261344.0 262473.0 262846.0 263486.0 58292.4 59516.0 59583.4 59595.4 59645.1 34327.3 34977.8 35149.5 37294.6 62428.7 14042.4 14113.6 14120.5 14137.8 14150.5 10121.6 10129.7 10130.0 10154.3 10165.0 19683.0 19732.0 19821.0 19942.6 20040.5 7157.0 7389.6 7512.2 7528.9 7551.7 807.4 823.6 979.8 982.5 982.9 28461.3 28784.3 28983.9 29473.6 29544.7 762.9 979.4 980.5 1007.2 1019.4 13995.7 15038.2 15062.3 15251.3 15525.2 409820.0 410644.0 413342.0 413387.0 414338.0 52113.7 52510.7 52620.5 52658.2 52744.7 1086.1 1121.3 1151.5 1185.1 1210.5 27251.0 29652.4 30107.7 30838.4 30867.5 44049.3 44544.6 44640.6 44651.6 44685.6 249702.0 250824.0 251060.0 251067.0 251434.0 25771.2 26768.9 26784.0 26833.6 26865.7 42997.8 43219.8 43421.8 44235.0 44406.0 36770.4 37133.3 37390.3 38139.4 38168.4 36667.0 36794.4 37011.6 37234.0 37711.4 36349.6 36584.3 36969.8 37001.4 37797.0 31495.5 33940.0 34039.8 34061.3 34276.5 25586.4 25656.9 25743.0 25927.5 26059.2 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#2] jquery.html Cycles:180 Average:24468.82 Median:4382.53 stddev:65471.62 (1493.9%) stddev-sans-first:65630.22 15:42:43 INFO - PROCESS | 12085 | Values: 340.3 363.5 371.2 375.5 388.4 13040.3 16417.3 16957.6 18114.8 18417.1 16976.9 16987.8 17050.5 17105.1 17247.8 5016.7 5107.9 5357.8 5384.3 5435.7 3464.9 5396.8 5421.2 5427.5 5674.5 5967.8 6003.2 6023.7 6035.0 6041.1 5838.1 5885.2 5928.5 5939.4 6000.4 5291.7 5299.5 5300.9 5304.6 5305.7 12726.7 20733.7 21050.8 21142.7 21211.0 1811.1 1842.8 1866.0 1892.2 1905.0 8794.4 9280.2 9287.4 9637.8 12781.7 1743.1 1805.0 1841.6 1850.7 1875.8 66400.0 68010.7 69452.7 71560.0 72270.6 9875.3 10039.1 10167.9 10205.1 10241.7 14012.6 14036.9 14047.0 14050.6 14083.8 6945.9 7056.5 7174.8 7207.9 7219.7 6504.3 6612.7 6615.7 6790.3 6799.0 4328.7 4376.0 4389.1 4424.6 4493.8 1793.8 1839.3 1852.5 1863.3 1864.1 813.0 822.0 866.6 903.5 961.5 16445.8 16466.0 17313.5 17628.6 17754.5 852.4 858.3 873.0 885.5 925.6 9419.2 9685.0 9935.4 9969.5 10101.7 377051.0 395418.0 404011.0 404711.0 405125.0 70170.0 73473.0 73553.0 74062.0 76740.6 892.5 898.4 923.3 926.7 928.4 15375.8 15450.8 15616.3 16188.4 16207.8 34987.8 35471.6 36380.5 36559.8 37525.4 48042.5 50166.7 50201.7 50714.7 51403.0 6484.2 6914.3 7034.6 7049.5 8051.2 10113.9 11952.9 12099.4 12313.1 12352.3 9614.2 9762.2 9774.4 9856.4 10095.3 10238.4 10373.1 10431.2 10495.9 10536.7 6795.8 7629.1 9707.8 9936.2 10258.0 10758.2 10965.0 11091.4 11360.9 11804.9 10589.6 10696.0 10699.2 10864.4 11338.2 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#3] mootools.html Cycles:180 Average:4921.05 Median:4875.85 stddev:2777.48 (57.0%) stddev-sans-first:2771.65 15:42:43 INFO - PROCESS | 12085 | Values: 1260.6 1329.6 1388.4 1435.7 1678.5 6504.2 7143.7 7500.0 7503.4 7722.4 7487.5 7487.7 7504.1 7537.1 7557.8 2172.9 2195.5 2201.4 2204.3 2204.4 2150.9 2198.0 2202.5 2209.5 2212.8 2082.5 2089.5 2097.1 2106.8 2130.4 2087.9 2094.7 2095.2 2095.7 2097.2 2065.2 2124.5 2126.0 2126.9 2131.2 7360.2 7413.4 7551.6 7587.2 7595.6 4234.9 4414.0 4419.1 4419.9 4435.0 2792.6 2899.4 2919.5 2923.0 2930.9 910.2 911.6 928.6 932.2 936.9 10120.5 10215.6 10263.5 10275.2 10275.5 3683.2 3810.8 3932.6 3961.5 3979.0 8141.4 8160.0 8164.5 8192.0 8203.3 4300.2 4304.0 4304.2 4312.0 4312.4 3487.7 3800.8 3944.2 3993.4 3995.4 3345.8 3375.4 3482.9 3491.2 3491.7 1018.2 1026.1 1028.8 1068.9 1069.4 674.0 724.0 762.7 810.8 827.7 4855.6 4896.1 4935.7 5156.9 5348.5 370.0 371.0 375.3 392.4 406.1 3266.5 3440.5 3459.6 3477.8 3571.8 8582.9 9302.3 9368.7 9379.4 9420.0 9350.8 9350.8 9351.1 9354.7 9356.9 6987.5 7196.2 7235.6 7238.9 7242.5 5005.9 5043.2 5122.9 5125.8 5137.5 8293.5 8609.0 8617.9 8689.1 8712.5 8620.7 8757.5 8871.6 8911.7 8936.9 5776.1 6331.1 6500.5 6639.5 6647.3 7021.4 7119.9 7259.6 7262.0 7271.7 6398.7 6403.3 6455.5 6495.9 6659.5 6436.4 6478.9 6487.5 6489.6 6508.6 6288.3 6398.6 6406.6 6409.5 6419.4 4267.3 4336.4 4441.0 4489.3 4510.5 4235.7 4256.1 4563.4 4584.0 4652.6 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#4] prototype.html Cycles:180 Average:4173.83 Median:4795.75 stddev:1197.99 (25.0%) stddev-sans-first:1165.29 15:42:43 INFO - PROCESS | 12085 | Values: 287.3 288.0 290.4 291.8 293.0 4867.4 4889.9 4893.8 4893.8 4916.5 4772.5 4794.5 4808.5 4823.8 4861.8 3603.1 3691.3 3694.8 3760.4 3805.8 3781.3 3783.6 3790.2 3809.8 3814.9 3709.4 3726.7 3735.3 3775.8 3782.8 3603.9 3639.4 3741.7 3757.7 3758.5 3335.6 3338.0 3354.5 3356.1 3361.6 4687.9 4724.6 4751.1 4768.7 4793.4 4234.9 4326.5 4348.5 4373.2 4383.3 5029.4 5030.6 5040.4 5042.9 5043.0 3636.7 3643.4 3646.8 3647.4 3675.2 5145.9 5332.2 5345.8 5373.5 5374.9 3704.6 3716.2 3723.9 3743.3 3744.5 3771.8 3780.4 3784.3 3799.8 3807.8 4296.2 4323.0 4324.4 4333.0 4341.2 4845.0 4990.4 5015.8 5017.4 5040.5 1285.5 1293.5 1297.6 1301.9 1303.2 845.3 848.4 868.4 870.3 889.9 4382.4 4411.9 4416.6 4420.4 4430.4 5129.7 5132.8 5150.6 5154.6 5169.7 4278.6 4407.9 4411.8 4414.4 4435.4 2714.7 2719.0 2731.1 2736.5 2737.8 4805.7 4819.2 4829.2 4833.5 4886.2 5103.6 5241.3 5278.9 5289.5 5291.0 4806.3 4813.7 4817.7 4822.4 4824.9 5050.4 5086.4 5095.0 5096.2 5125.1 4890.1 4942.2 4964.8 5029.8 5057.1 4790.5 4791.3 4797.0 4810.3 4824.9 3698.6 3707.1 3709.0 3743.1 3758.5 5012.9 5116.7 5158.3 5172.6 5177.8 4934.8 4950.4 4962.9 5025.8 5028.4 4961.6 4966.9 4971.8 4984.7 4990.6 4662.6 4847.6 4884.4 4900.3 4908.9 4768.8 4845.8 4949.3 4951.0 5011.9 4891.3 4900.7 4902.3 4913.4 4924.5 15:42:43 INFO - PROCESS | 12085 | 15:42:43 INFO - PROCESS | 12085 | [#5] yui.html Cycles:180 Average:17396.21 Median:24014.43 stddev:24565.81 (102.3%) stddev-sans-first:24602.51 15:42:43 INFO - PROCESS | 12085 | Values: 641.0 641.4 652.7 667.0 746.6 12157.8 12812.8 12815.5 12843.5 12852.0 12913.3 12916.9 12922.4 12923.9 12997.6 611.6 744.0 766.4 783.8 785.3 770.4 777.7 779.3 780.2 781.0 823.9 826.0 827.0 827.6 827.9 652.1 793.1 814.7 815.5 821.6 607.5 607.5 607.5 607.9 608.4 12773.7 12774.1 12800.7 12814.4 12817.9 12409.9 12657.9 13004.5 13312.1 13412.7 11200.8 11348.4 11588.1 11635.5 12113.9 4087.1 4107.1 4113.4 4189.4 4230.5 67301.3 67346.7 67404.3 67432.7 67468.3 10029.3 10161.2 10333.8 10459.2 10501.8 19451.7 19470.9 19488.8 19582.9 19601.4 6716.0 6765.7 6771.5 6778.6 6818.4 3779.8 3816.1 3819.4 3867.2 3882.9 2679.9 2794.1 2795.4 2796.2 2796.5 475.3 479.6 481.8 491.3 496.8 434.3 445.4 458.8 533.7 540.2 7801.3 7862.7 8057.6 8125.1 8130.8 487.3 489.8 498.6 535.3 642.1 3678.7 3922.5 4122.9 4305.5 4397.7 90249.0 90734.5 91197.5 93454.0 93881.0 82969.0 83252.6 83327.0 84087.6 84878.6 60164.7 66381.7 68905.3 70568.3 71334.0 7537.2 7623.1 7653.5 7947.7 7956.9 41882.4 42124.0 42892.8 43631.1 44130.8 54600.6 55959.7 63877.4 65004.7 65975.3 10048.5 10255.8 10509.9 10640.0 10749.2 11017.5 11109.6 11485.9 11829.9 11831.2 9867.1 10040.9 10666.2 10796.4 10890.8 10569.1 10746.4 10823.6 11083.4 12956.1 11468.8 11627.8 11922.3 12256.1 12281.4 9893.7 10059.6 10129.5 10375.8 10415.5 9964.0 10046.4 10130.8 10137.6 10157.6 15:42:43 INFO - PROCESS | 12085 | -------- Summary: end -------- 15:42:43 INFO - PROCESS | 12085 | 15:42:44 INFO - TEST-INFO | 12085: exit 0 15:42:44 INFO - TEST-OK | dromaeo_css | took 1120371ms 15:42:44 INFO - TEST-START | kraken 15:42:44 INFO - operating with platform_type : linux_ 15:42:44 INFO - Initialising browser for kraken test... 15:42:44 INFO - TEST-INFO | started process 12264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lAQhq/profile http://localhost:39125/getInfo.html) 15:42:49 INFO - PROCESS | 12264 | __metrics Screen width/height:1600/1200 15:42:49 INFO - PROCESS | 12264 | colorDepth:24 15:42:49 INFO - PROCESS | 12264 | Browser inner width/height: 1024/697 15:42:49 INFO - PROCESS | 12264 | __metrics 15:42:49 INFO - PROCESS | 12264 | 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:42:49 INFO - PROCESS | 12264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:50 INFO - TEST-INFO | 12264: exit 0 15:42:50 INFO - Browser initialized. 15:42:50 INFO - Running cycle 1/1 for kraken test... 15:42:50 INFO - TEST-INFO | started process 12342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lAQhq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:02 INFO - PROCESS | 12342 | RSS: Main: 158248960 15:43:02 INFO - PROCESS | 12342 | 15:43:05 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:06 INFO - PROCESS | 12342 | RSS: Main: 213786624 15:43:06 INFO - PROCESS | 12342 | 15:43:09 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-dft) 15:43:09 INFO - PROCESS | 12342 | RSS: Main: 191426560 15:43:09 INFO - PROCESS | 12342 | 15:43:13 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-fft) 15:43:13 INFO - PROCESS | 12342 | RSS: Main: 270987264 15:43:13 INFO - PROCESS | 12342 | 15:43:15 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-oscillator) 15:43:16 INFO - PROCESS | 12342 | RSS: Main: 180805632 15:43:16 INFO - PROCESS | 12342 | 15:43:18 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:19 INFO - PROCESS | 12342 | RSS: Main: 185212928 15:43:19 INFO - PROCESS | 12342 | 15:43:22 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:23 INFO - PROCESS | 12342 | RSS: Main: 221929472 15:43:23 INFO - PROCESS | 12342 | 15:43:26 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:27 INFO - PROCESS | 12342 | RSS: Main: 215052288 15:43:27 INFO - PROCESS | 12342 | 15:43:30 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39125/tests/kraken/driver.html?testName=json-parse-financial) 15:43:30 INFO - PROCESS | 12342 | RSS: Main: 218984448 15:43:30 INFO - PROCESS | 12342 | 15:43:32 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39125/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:33 INFO - PROCESS | 12342 | RSS: Main: 184598528 15:43:33 INFO - PROCESS | 12342 | 15:43:34 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:35 INFO - PROCESS | 12342 | RSS: Main: 189706240 15:43:35 INFO - PROCESS | 12342 | 15:43:37 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:38 INFO - PROCESS | 12342 | RSS: Main: 194297856 15:43:38 INFO - PROCESS | 12342 | 15:43:41 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:41 INFO - PROCESS | 12342 | RSS: Main: 188981248 15:43:41 INFO - PROCESS | 12342 | 15:43:44 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:45 INFO - PROCESS | 12342 | RSS: Main: 192868352 15:43:45 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39125/tests/kraken/driver.html?testName=ai-astar) 15:43:47 INFO - PROCESS | 12342 | RSS: Main: 242896896 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | __start_tp_report 15:43:47 INFO - PROCESS | 12342 | _x_x_mozilla_page_load 15:43:47 INFO - PROCESS | 12342 | _x_x_mozilla_page_load_details 15:43:47 INFO - PROCESS | 12342 | |i|pagename|runs| 15:43:47 INFO - PROCESS | 12342 | |0;ai-astar;104;114;114;113;114;112;113;114;112;113 15:43:47 INFO - PROCESS | 12342 | |1;audio-beat-detection;154;124;124;189;125;124;147;125;155;129 15:43:47 INFO - PROCESS | 12342 | |2;audio-dft;162;162;161;162;161;161;162;161;160;161 15:43:47 INFO - PROCESS | 12342 | |3;audio-fft;76;76;75;126;76;78;75;76;103;75 15:43:47 INFO - PROCESS | 12342 | |4;audio-oscillator;85;85;130;84;84;85;128;84;84;135 15:43:47 INFO - PROCESS | 12342 | |5;imaging-gaussian-blur;116;117;116;116;117;117;116;117;116;117 15:43:47 INFO - PROCESS | 12342 | |6;imaging-darkroom;146;146;147;146;147;147;147;147;147;147 15:43:47 INFO - PROCESS | 12342 | |7;imaging-desaturate;94;95;94;95;95;95;95;96;94;95 15:43:47 INFO - PROCESS | 12342 | |8;json-parse-financial;64;63;63;64;65;65;63;63;63;63 15:43:47 INFO - PROCESS | 12342 | |9;json-stringify-tinderbox;65;66;65;66;65;66;67;66;67;65 15:43:47 INFO - PROCESS | 12342 | |10;stanford-crypto-aes;80;79;80;80;80;80;79;85;88;82 15:43:47 INFO - PROCESS | 12342 | |11;stanford-crypto-ccm;131;130;139;129;131;130;138;136;173;131 15:43:47 INFO - PROCESS | 12342 | |12;stanford-crypto-pbkdf2;167;172;167;171;163;169;165;169;165;165 15:43:47 INFO - PROCESS | 12342 | |13;stanford-crypto-sha256-iterative;68;68;67;68;66;68;68;66;67;66 15:43:47 INFO - PROCESS | 12342 | __end_tp_report 15:43:47 INFO - PROCESS | 12342 | __start_cc_report 15:43:47 INFO - PROCESS | 12342 | _x_x_mozilla_cycle_collect,1972 15:43:47 INFO - PROCESS | 12342 | __end_cc_report 15:43:47 INFO - PROCESS | 12342 | __startTimestamp1470264227273__endTimestamp 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | ------- Summary: start ------- 15:43:47 INFO - PROCESS | 12342 | Number of tests: 14 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 15:43:47 INFO - PROCESS | 12342 | Values: 104.0 114.0 114.0 113.0 114.0 112.0 113.0 114.0 112.0 113.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:138.00 stddev:21.62 (15.7%) stddev-sans-first:22.30 15:43:47 INFO - PROCESS | 12342 | Values: 154.0 124.0 124.0 189.0 125.0 124.0 147.0 125.0 155.0 129.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 15:43:47 INFO - PROCESS | 12342 | Values: 162.0 162.0 161.0 162.0 161.0 161.0 162.0 161.0 160.0 161.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:17.19 (22.6%) stddev-sans-first:18.01 15:43:47 INFO - PROCESS | 12342 | Values: 76.0 76.0 75.0 126.0 76.0 78.0 75.0 76.0 103.0 75.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:84.00 stddev:22.56 (26.9%) stddev-sans-first:23.41 15:43:47 INFO - PROCESS | 12342 | Values: 85.0 85.0 130.0 84.0 84.0 85.0 128.0 84.0 84.0 135.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:43:47 INFO - PROCESS | 12342 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 15:43:47 INFO - PROCESS | 12342 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:43:47 INFO - PROCESS | 12342 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:43:47 INFO - PROCESS | 12342 | Values: 64.0 63.0 63.0 64.0 65.0 65.0 63.0 63.0 63.0 63.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 15:43:47 INFO - PROCESS | 12342 | Values: 65.0 66.0 65.0 66.0 65.0 66.0 67.0 66.0 67.0 65.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:2.95 (3.7%) stddev-sans-first:3.09 15:43:47 INFO - PROCESS | 12342 | Values: 80.0 79.0 80.0 80.0 80.0 80.0 79.0 85.0 88.0 82.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:133.50 stddev:13.21 (9.9%) stddev-sans-first:13.85 15:43:47 INFO - PROCESS | 12342 | Values: 131.0 130.0 139.0 129.0 131.0 130.0 138.0 136.0 173.0 131.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:2.91 (1.7%) stddev-sans-first:3.08 15:43:47 INFO - PROCESS | 12342 | Values: 167.0 172.0 167.0 171.0 163.0 169.0 165.0 169.0 165.0 165.0 15:43:47 INFO - PROCESS | 12342 | 15:43:47 INFO - PROCESS | 12342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 15:43:47 INFO - PROCESS | 12342 | Values: 68.0 68.0 67.0 68.0 66.0 68.0 68.0 66.0 67.0 66.0 15:43:47 INFO - PROCESS | 12342 | -------- Summary: end -------- 15:43:47 INFO - PROCESS | 12342 | 15:43:48 INFO - TEST-INFO | 12342: exit 0 15:43:48 INFO - TEST-OK | kraken | took 63631ms 15:43:48 INFO - SUITE-END | took 1184s 15:43:48 INFO - Completed test suite (00:19:44) 15:43:48 INFO - javascript benchmark 15:43:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.3007817967323, 2689.421774318522, 2723.822951508151, 2731.289864635194, 2735.4665840161165, 4658.347831303612, 4701.2478003519445, 4850.951490485094, 4906.0433215523035, 4919.385076865392, 4712.3873896393425, 4861.73260470674, 4868.56182943535, 4914.97542512287, 4964.503549645034, 4393.011572396217, 4447.799849006787, 4492.573205545468, 4526.185286648402, 4603.470600880892, 4535.659825513099, 4587.311903214528, 4597.103564804865, 4619.769011549426, 4633.49031606523, 4338.2191205582985, 4527.615152712024, 4539.024109816405, 4585.5185205553435, 4640.883977900546, 4369.694121411502, 4416.911661766747, 4427.734335939822, 4479.574440428187, 4494.483134439549, 4395.208862404766, 4398.076403955141, 4434.1131773645075, 4437.33439984005, 4451.354553589711, 4856.271559266103, 4868.075065737534, 4893.486183950669, 4917.655764096515, 4931.235658472942, 5024.497550244946, 5082.669626474268, 5176.611754118456, 5180.974095129538, 5262.368515778093, 5241.50205730455, 5262.789488420459, 5276.366835979668, 5289.0, 5293.655912365684, 4700.858974230779, 4869.14789911764, 4870.269459581091, 4903.41159060915, 4907.484714105039, 5275.155975043975, 5319.494648008433, 5329.8934021319355, 5330.866728331745, 5424.321959755031, 5127.820526281562, 5173.81891633791, 5174.741262936914, 5179.81870634526, 5180.0, 4972.378452693413, 5217.165253559412, 5219.895602087937, 5269.420363759983, 5285.392179899284, 5145.639805213674, 5191.740412979336, 5199.948000520022, 5228.058949389147, 5295.391030031518, 5208.817691380784, 5211.166213405837, 5213.582913366921, 5223.2948551945765, 5264.184051472028, 4099.3031184698675, 4381.014271788822, 4387.166438376698, 4400.779961002001, 4431.357453169272, 3631.94552081719, 3750.568684601306, 3765.7175711821724, 3825.6365645263654, 3902.726809123334, 4445.0, 4452.354408610733, 4453.799579018952, 4477.70894891831, 4497.887552811206, 5169.689818610896, 5180.948190518122, 5181.948180518222, 5190.299309593157, 5195.19474481456, 4334.934975975363, 4404.911901761947, 4435.246008178618, 4438.245498265303, 4512.932306015412, 4620.607248383858, 4631.235846085358, 4643.094596553708, 4648.825604362251, 4695.694779839299, 4840.104580652591, 4874.2444921037295, 4886.486918873609, 4896.755162241945, 4961.454240033666, 5039.294498770102, 5116.720819795051, 5161.8451446455165, 5163.199704045879, 5298.70857102863, 4874.098291816025, 4884.0, 4902.5587697106, 4911.459739428588, 4954.405471343318, 5168.819091331786, 5175.81884634036, 5184.818531351385, 5185.559227465707, 5194.065068287593, 5034.899302013866, 5110.131277682728, 5155.948440515697, 5164.896702065863, 5242.213667949838, 5015.473375295687, 5025.070361983045, 5041.067402530543, 5042.773075211551, 5078.415982162099, 5016.097102521581, 5026.195808670595, 5027.145385284583, 5030.0, 5051.419086805065, 4808.663393562417, 4909.533594308535, 4963.851084467472, 4976.601871850316, 5037.571806396498, 5078.365204349457, 5087.08432482142, 5088.313077734459, 5090.592752579859, 5136.640435169502, 4939.086269040239, 4978.975105124451, 4980.526849949249, 4982.227754698028, 4983.227599722049], "value": 4765.430933040499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6482445708117, 584.2113147251209, 592.0674936974264, 592.2803793391029, 597.0, 29793.702062979362, 39253.01867453315, 40924.97687557809, 40928.38607420884, 45074.32388514175, 41983.370249446285, 42359.15281694364, 42368.576314236845, 42380.0, 42582.0, 7696.769096927087, 7836.764897053097, 7852.685892564291, 7871.921280787176, 7884.448088633798, 7686.846263074735, 7759.689612415496, 7780.649870755829, 7796.727114550963, 7801.063872335328, 7804.336631386339, 7856.803579910491, 7859.096203936563, 7862.567558784264, 7864.370850331989, 7731.188225236354, 7768.184340644264, 7795.259450352208, 7796.883046754303, 7814.882776758353, 7737.535747855147, 7801.531908085476, 7814.413918956101, 7814.531128132274, 7820.061592608867, 39611.40582891259, 39844.0, 39928.0, 39971.600283997075, 39982.800085999676, 3130.280035591804, 3137.7332926701256, 3529.347070791886, 3742.4760533525327, 3844.730868839182, 30176.651343934685, 30879.691203087907, 31008.8449557753, 31237.37525249505, 33692.49461258083, 3280.622728386242, 3378.6735504368644, 3395.2360718838063, 3406.7104296134858, 3547.396942519752, 257751.0, 261344.0, 262473.0, 262846.0, 263486.0, 58292.417075829544, 59516.0, 59583.404165957785, 59595.40404595899, 59645.10532342018, 34327.313453730785, 34977.82511087479, 35149.472757908654, 37294.62705372966, 62428.68785656134, 14042.438302467786, 14113.576592702235, 14120.505782297776, 14137.78793318101, 14150.504732334524, 10121.595136194617, 10129.696109116738, 10130.037646423578, 10154.289199756095, 10165.034321739422, 19683.0, 19732.0, 19821.0, 19942.60114797725, 20040.49898752543, 7156.964215178995, 7389.593572353572, 7512.21121782205, 7528.924710752932, 7551.73568925085, 807.4428644235459, 823.5635113389912, 979.7844474215661, 982.4645568165367, 982.8722266105503, 28461.288467788472, 28784.280392990342, 28983.85508072446, 29473.557896631566, 29544.704552954194, 762.9160792312841, 979.4368238262884, 980.5342462330478, 1007.2294694558668, 1019.3628981886321, 13995.720085598232, 15038.248087595577, 15062.322195501229, 15251.313690883937, 15525.223738813014, 409820.0, 410644.0, 413342.0, 413387.0, 414338.0, 52113.73943130336, 52510.73744631252, 52620.473795262325, 52658.21012684813, 52744.73627631837, 1086.1039642295138, 1121.315997241682, 1151.4760783843499, 1185.1170877696172, 1210.4734440518403, 27251.0, 29652.406951860412, 30107.69892301049, 30838.383232335676, 30867.536986944764, 44049.339259911765, 44544.55455445534, 44640.55359446364, 44651.553484466036, 44685.55314446814, 249702.0, 250824.0, 251060.0, 251067.0, 251434.0, 25771.226863194133, 26768.866155669097, 26784.0, 26833.597496037186, 26865.731342686322, 42997.785011076, 43219.78390108029, 43421.818923937106, 44235.0, 44406.0, 36770.448443272835, 37133.25733485369, 37390.25219495541, 38139.42790858084, 38168.42747358736, 36667.0, 36794.448083279305, 37011.6298837019, 37234.0, 37711.434328485644, 36349.636503634625, 36584.26831463409, 36969.81515092515, 37001.44497832588, 37797.0, 31495.527567086054, 33940.0, 34039.829800851825, 34061.31877362489, 34276.48585271273, 25586.360340991625, 25656.871715641304, 25743.0, 25927.481450371266, 26059.21822345333], "value": 17735.999482496787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2672680692799, 363.53830635093414, 371.20006386237657, 375.4837098988891, 388.39410519589444, 13040.282784446852, 16417.34330626775, 16957.576060598476, 18114.818851811477, 18417.07914604271, 16976.915115424435, 16987.83012169878, 17050.48848534546, 17105.144742762845, 17247.82752172478, 5016.69899806011, 5107.923381149286, 5357.785688572472, 5384.326959130109, 5435.701036442994, 3464.861405543788, 5396.78412863485, 5421.21392398102, 5427.538659213971, 5674.517665998395, 5967.761289548413, 6003.219581454405, 6023.6988150592515, 6035.0, 6041.093835924625, 5838.065909454509, 5885.234919460464, 5928.466438020556, 5939.4357536034, 6000.3699611540815, 5291.682499050069, 5299.54953828925, 5300.946990530122, 5304.6286759926825, 5305.681659100428, 12726.68183295425, 20733.68899466509, 21050.78949210519, 21142.682859757115, 21211.045502952406, 1811.0854018720593, 1842.7512285841374, 1866.038989920192, 1892.1579896945864, 1904.9619007619908, 8794.384393092487, 9280.211182049534, 9287.442753434749, 9637.807243855154, 12781.744365112645, 1743.128435782109, 1804.9729254061199, 1841.5764374194011, 1850.685383484811, 1875.7936626971023, 66400.0, 68010.65994670044, 69452.6527367365, 71560.0, 72270.63864680695, 9875.259355548362, 10039.146672532917, 10167.949160254151, 10205.132563732017, 10241.74395640115, 14012.579622611338, 14036.859631403759, 14047.016708830284, 14050.648733781532, 14083.788743168861, 6945.93054069463, 7056.54132481387, 7174.784756457315, 7207.89188162178, 7219.711211551479, 6504.317046710122, 6612.7354905804195, 6615.66921653925, 6790.32096790317, 6798.966005170041, 4328.718633288826, 4375.956240437618, 4389.100234451929, 4424.6239069678795, 4493.775311234425, 1793.847522960563, 1839.3010655950652, 1852.4905650945827, 1863.3292014874635, 1864.0613761687964, 812.9674813007414, 822.0258993093084, 866.5927014303268, 903.4985583001497, 961.4711908450324, 16445.83554164467, 16466.0, 17313.480595582154, 17628.618479791996, 17754.467365979042, 852.4331319672349, 858.3090612057229, 872.9912700873037, 885.5085427587621, 925.5511077127587, 9419.15227629503, 9684.95157524208, 9935.354201976848, 9969.501524923724, 10101.69694909154, 377051.0, 395418.0, 404011.0, 404711.0, 405125.0, 70170.0, 73473.0, 73553.0, 74062.0, 76740.61629691928, 892.5314210039782, 898.3576742629182, 923.2660035271975, 926.7497775600685, 928.4150984879483, 15375.846241537442, 15450.84549154494, 15616.297266623256, 16188.433404830774, 16207.837921620632, 34987.82506087453, 35471.64528354684, 36380.454293185096, 36559.81720091382, 37525.4371184427, 48042.5195748038, 50166.74916625393, 50201.74899125481, 50714.74642626763, 51402.97194056173, 6484.221893372825, 6914.274001229798, 7034.648267586498, 7049.541779784297, 8051.194880511902, 10113.949430252802, 11952.880471195176, 12099.395030248277, 12313.076519260912, 12352.25886446816, 9614.18279446255, 9762.219022478326, 9774.364666296668, 9856.359336643096, 10095.293329466867, 10238.385696858213, 10373.066424021874, 10431.16550675929, 10495.947520262349, 10536.736581585521, 6795.830104247433, 7629.122650894996, 9707.805843882941, 9936.168192065516, 10258.0, 10758.193135514712, 10965.0, 11091.44542772842, 11360.886391135982, 11804.940975295069, 10589.576416943237, 10696.03735663794, 10699.197560182862, 10864.402457864893, 11338.206325557132], "value": 8294.647685318721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.6281147061616, 1329.5545992092648, 1388.4307433952079, 1435.7272118297524, 1678.5384019394673, 6504.219493660761, 7143.678534465948, 7499.9875016872775, 7503.362214211798, 7722.420818438625, 7487.475876688621, 7487.700491980314, 7504.061992250969, 7537.095548534184, 7557.848843023136, 2172.880491572967, 2195.495036141688, 2201.3946164804647, 2204.3166618348364, 2204.4488877780555, 2150.935287032913, 2198.0218802632835, 2202.493426511903, 2209.4807720185745, 2212.83403744719, 2082.458560774202, 2089.529855782452, 2097.1192099318246, 2106.8314534837177, 2130.3928380411585, 2087.8642888212294, 2094.7276854009033, 2095.182878677317, 2095.6961240620176, 2097.213544920655, 2065.2461851424273, 2124.5326028273753, 2126.032655141922, 2126.861753985986, 2131.1794958940764, 7360.153582337993, 7413.369863561604, 7551.584662843541, 7587.165411804697, 7595.582242976634, 4234.87295381139, 4414.0, 4419.0940857124215, 4419.889502762425, 4434.977825110854, 2792.581112833071, 2899.449104670106, 2919.459899918522, 2922.970770292291, 2930.9413811723857, 910.2172131966504, 911.6080085563206, 928.6285485805664, 932.1936524905908, 936.892257390402, 10120.493975301206, 10215.591376344937, 10263.486825658762, 10275.229357798195, 10275.486225688686, 3683.244934788362, 3810.8285127169343, 3932.5870783567884, 3961.504811898513, 3979.0, 8141.389395795339, 8160.0, 8164.510129392255, 8192.0, 8203.30271926881, 4300.182965236595, 4304.031592891574, 4304.225239456928, 4312.029793296483, 4312.37470566766, 3487.7035451986358, 3800.7909564974193, 3944.2111577684577, 3993.381025940984, 3995.420664003703, 3345.815980121068, 3375.4430518964587, 3482.89551313461, 3491.17957280039, 3491.6857482826667, 1018.2261481274137, 1026.1226651213105, 1028.8148133335922, 1068.9144868410508, 1069.3851035654375, 673.9932600674028, 723.9565626062453, 762.7139822566537, 810.7527204202656, 827.7020272701823, 4855.635827312895, 4896.069746748107, 4935.728534930613, 5156.948430515722, 5348.465153484698, 370.0286747288368, 370.98535505392726, 375.3337825360008, 392.40942381715337, 406.0761766980085, 3266.530061472347, 3440.535527703778, 3459.636738142459, 3477.7739446935866, 3571.821408929543, 8582.87125693115, 9302.348835581444, 9368.67209647659, 9379.390339627902, 9420.0, 9350.766230844147, 9350.812983740287, 9351.111644393772, 9354.672586459441, 9356.859647105299, 6987.510874238857, 7196.244394338519, 7235.63821808897, 7238.92761072393, 7242.529235599669, 5005.899882002267, 5043.2435134730085, 5122.871928201825, 5125.820596279113, 5137.537621614073, 8293.543855087786, 8609.0, 8617.87073193915, 8689.0876457971, 8712.477251364939, 8620.655173792979, 8757.47455152693, 8871.64513419456, 8911.73264802057, 8936.910630893608, 5776.104703770922, 6331.050342448485, 6500.5449618526245, 6639.535232533676, 6647.302033286435, 7021.368076873106, 7119.928800711927, 7259.564426134449, 7262.0, 7271.745488907863, 6398.712057957497, 6403.263624683034, 6455.515836312389, 6495.9025614614875, 6659.500537459613, 6436.388543088399, 6478.870422591616, 6487.513436492188, 6489.610623362613, 6508.576942498722, 6288.27684816252, 6398.5521013528605, 6406.647634380154, 6409.487241020801, 6419.422251997343, 4267.274563324305, 4336.39290499324, 4441.0, 4489.259272220178, 4510.50384457716, 4235.682323825787, 4256.106217694195, 4563.406757121553, 4584.0, 4652.55800698933], "value": 3889.0076710122216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.2961244949873, 287.9697631748666, 290.3612053482337, 291.77824853111645, 293.0446743615812, 4867.3915760529935, 4889.902201955959, 4893.755312234387, 4893.8287159949405, 4916.532929371713, 4772.451168115667, 4794.496577859327, 4808.54764070324, 4823.78292976816, 4861.756912154387, 3603.117236277116, 3691.335559599271, 3694.8152592370407, 3760.4359346098167, 3805.771653700787, 3781.3193625147464, 3783.602721714222, 3790.2040571480024, 3809.8285577149095, 3814.8555433370016, 3709.4250391189275, 3726.6646001859826, 3735.2902948439846, 3775.754575952568, 3782.8108594570162, 3603.873864414746, 3639.363111455498, 3741.681957033655, 3757.6993840492696, 3758.5489741230954, 3335.5997280326274, 3337.9833100834585, 3354.480055591387, 3356.1038013522284, 3361.5798025246845, 4687.929681054787, 4724.574788269072, 4751.121042607128, 4768.73771942543, 4793.400824896888, 4234.894127646803, 4326.502452218004, 4348.456442944632, 4373.234683930331, 4383.298672212462, 5029.4216165141115, 5030.647854650176, 5040.395152581677, 5042.924356134624, 5042.991401719671, 3636.672699457035, 3643.3806252936797, 3646.762960407565, 3647.4467872489363, 3675.1547144156993, 5145.897082058375, 5332.226827110087, 5345.797195630952, 5373.5163835254625, 5374.865628359284, 3704.555453345562, 3716.1638631307737, 3723.8696645617274, 3743.344914639927, 3744.475773391727, 3771.7935008020613, 3780.3762379207674, 3784.2942296258307, 3799.7720136791327, 3807.790571518593, 4296.174125996439, 4323.027318853233, 4324.372965919924, 4332.956670433318, 4341.175176716414, 4844.95155048452, 4990.3762029746285, 5015.84635533822, 5017.397912250553, 5040.546350828443, 1285.5152299094561, 1293.5149319005372, 1297.6172029251393, 1301.9218846869219, 1303.1855090568395, 845.3152946113668, 848.3510114762212, 868.4108082209541, 870.3428911172151, 889.888763904512, 4382.386465894777, 4411.852918241216, 4416.580424859633, 4420.359047938031, 4430.424044874146, 5129.743512824344, 5132.769025393866, 5150.639455238097, 5154.613403994716, 5169.68981861082, 4278.593533614302, 4407.933880991788, 4411.845585404495, 4414.359917811899, 4435.423394958635, 2714.7013828478853, 2718.9803823566162, 2731.085086496006, 2736.53478908586, 2737.7809775217934, 4805.735684537384, 4819.204831202883, 4829.227323628203, 4833.516648335139, 4886.218205087169, 5103.617228707862, 5241.292425522505, 5278.868028299324, 5289.487493440662, 5291.0, 4806.327114204014, 4813.663043586916, 4817.710937343771, 4822.445418776885, 4824.927626085611, 5050.419201791841, 5086.364204474441, 5095.0, 5096.165380462956, 5125.103106956193, 4890.133992662267, 4942.184539550934, 4964.751762411793, 5029.823956161516, 5057.089723849743, 4790.496997815179, 4791.329213909986, 4797.0, 4810.302506136521, 4824.903501930012, 3698.63013698628, 3707.1473561081643, 3709.0, 3743.1016556026902, 3758.5489741231227, 5012.924806127838, 5116.667416617908, 5158.303629010035, 5172.586193104467, 5177.792888284426, 4934.802607895644, 4950.430700469492, 4962.851114466572, 5025.824096156617, 5028.446870844277, 4961.578265847299, 4966.8758281043265, 4971.751412429292, 4984.728894131973, 4990.6007519397635, 4662.580367766917, 4847.612191024639, 4884.413870335582, 4900.338454308623, 4908.9263661045825, 4768.809247630056, 4845.830395936126, 4949.307097006494, 4950.970102258057, 5011.949880501148, 4891.29076283944, 4900.681455705368, 4902.289168070539, 4913.410390753133, 4924.532169443897], "value": 3790.8402718056345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9839754006149, 641.397086738466, 652.6954733532352, 667.0461240426189, 746.6416120262274, 12157.817632735516, 12812.782785635362, 12815.487380504781, 12843.486260549591, 12852.0, 12913.289769062698, 12916.870831291684, 12922.353882305893, 12923.870761292384, 12997.61007169784, 611.626907586372, 743.9925600744004, 766.4251811141644, 783.7805414483925, 785.2853902948318, 770.4106358635648, 777.7472321495509, 779.3336697123963, 780.2236774409442, 780.9687612495493, 823.9464434811748, 826.0335407573153, 827.0447632983913, 827.6192951242435, 827.9461834980738, 652.0935899100255, 793.1196372027046, 814.7433558429105, 815.514768712615, 821.5645707774829, 607.4745345276305, 607.5200591532683, 607.5443417436923, 607.872346807171, 608.4007252855934, 12773.74452510954, 12774.105812593121, 12800.743985120245, 12814.42335094923, 12817.935910320482, 12409.875901240963, 12657.93671031639, 13004.544840930617, 13312.068155229137, 13412.731745365136, 11200.770686119244, 11348.375839328834, 11588.072954163647, 11635.476403561861, 12113.878861211364, 4087.1008378156757, 4107.096438783463, 4113.382992551112, 4189.371594260855, 4230.450041494617, 67301.32698673049, 67346.66326668335, 67404.3259567403, 67432.662836686, 67468.32531674669, 10029.348092373972, 10161.237907156992, 10333.793324133625, 10459.215558833119, 10501.842472362921, 19451.708224376645, 19470.902645486964, 19488.805111948983, 19582.90208548948, 19601.411957641292, 6715.966420167868, 6765.661716914135, 6771.492138089565, 6778.593284402951, 6818.420434263143, 3779.8110094495164, 3816.0650640592676, 3819.4079917612817, 3867.245887052054, 3882.902927426837, 2679.9464010720067, 2794.0639885638134, 2795.4269374778123, 2796.24501384625, 2796.454691335211, 475.30130707859394, 479.6115146731089, 481.7543053042903, 491.33669546113174, 496.76900241387926, 434.2595874034763, 445.4409715806642, 458.8187665871962, 533.7011273686747, 540.2436588775745, 7801.29788319054, 7862.685492580347, 8057.6374063167295, 8125.1062383137805, 8130.796730081795, 487.30802260789056, 489.7649128418308, 498.5637567128762, 535.3067777228498, 642.1042645509488, 3678.6505281998166, 3922.4620382935605, 4122.928038709957, 4305.461817272841, 4397.73613583186, 90249.0, 90734.54632726795, 91197.54401227951, 93454.0, 93881.0, 82969.02185868747, 83252.58373708093, 83327.0, 84087.57956210303, 84878.57560712157, 60164.69917650471, 66381.66809165923, 68905.3109468909, 70568.29431705618, 71334.0, 7537.2462753724185, 7623.123340815877, 7653.464257501922, 7947.682092716226, 7956.880646790187, 41882.37176442417, 42124.0, 42892.78553607212, 43631.12737745291, 44130.77934610435, 54600.63498412572, 55959.72020140036, 63877.36122638714, 65004.67497662482, 65975.34024659693, 10048.547815348473, 10255.794884102126, 10509.894901050891, 10640.0, 10749.193810464403, 11017.504212310305, 11109.611163609236, 11485.942570287096, 11829.940850295694, 11831.230969987268, 9867.06262905023, 10040.949795250977, 10666.200034997251, 10796.406197659204, 10890.782184356427, 10569.101626361538, 10746.355218686904, 10823.56705731762, 11083.445827708743, 12956.093073484766, 11468.770624587294, 11627.825582616098, 11922.344271065174, 12256.080793940668, 12281.385930703607, 9893.703188904345, 10059.647912323033, 10129.493525323556, 10375.844362334721, 10415.53130109162, 9963.957388735436, 10046.447445390282, 10130.8480372793, 10137.64518241858, 10157.644482443078], "value": 6453.8278381748, "unit": "score"}], "name": "dromaeo_css", "value": 6368.443440131951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 114.0, 112.0, 113.0, 114.0, 112.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 124.0, 189.0, 125.0, 124.0, 147.0, 125.0, 155.0, 129.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 126.0, 76.0, 78.0, 75.0, 76.0, 103.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 130.0, 84.0, 84.0, 85.0, 128.0, 84.0, 84.0, 135.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 65.0, 65.0, 63.0, 63.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 80.0, 80.0, 79.0, 85.0, 88.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 139.0, 129.0, 131.0, 130.0, 138.0, 136.0, 173.0, 131.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 167.0, 171.0, 163.0, 169.0, 165.0, 169.0, 165.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 66.0, 68.0, 68.0, 66.0, 67.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1535.1999999999998, "alertThreshold": 2.0}]} 15:43:48 INFO - Return code: 0 15:43:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:43:48 INFO - # TBPL SUCCESS # 15:43:48 INFO - Running post-action listener: _resource_record_post_action 15:43:48 INFO - [mozharness: 2016-08-03 22:43:48.560199Z] Finished run-tests step (success) 15:43:48 INFO - Running post-run listener: _resource_record_post_run 15:43:48 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 532197376; Read time: 348; Write time: 653940 15:43:48 INFO - TinderboxPrint: CPU usage
13.0% 15:43:48 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 348 15:43:48 INFO - TinderboxPrint: I/O write bytes / time
532,197,376 / 653,940 15:43:48 INFO - TinderboxPrint: CPU idle
8,330.0 (87.0%) 15:43:48 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 15:43:48 INFO - TinderboxPrint: Swap in / out
0 / 0 15:43:48 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248041472; Read time: 0; Write time: 379624 15:43:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284155904; Read time: 332; Write time: 274316 15:43:49 INFO - Running post-run listener: _upload_blobber_files 15:43:49 INFO - Blob upload gear active. 15:43:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:43:49 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 15:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:43:49 INFO - (blobuploader) - INFO - Open directory for files ... 15:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:52 INFO - (blobuploader) - INFO - Done attempting. 15:43:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:43:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:53 INFO - (blobuploader) - INFO - Done attempting. 15:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:43:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:54 INFO - (blobuploader) - INFO - Done attempting. 15:43:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:43:54 INFO - Return code: 0 15:43:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:43:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:43:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f156844e1587e93536255aac2d7ae86bd1e8a23dd7b7392391993803af1ce071eefdd97e7e6b33cef68486c711f6441134536d963358cea61bb3da8a8a2aad0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b5338e63892534b8da9ec2720b9a28c1496d5940ec1d6b36a595982f119a8c725b5cb1d490f557107e041baf94ba7d9f71d4caf009b8d53e06b2d1b35eb229d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792dcb58041e5469f49551b2e043a01be00155167f4a8ab830653f83bd3441469aa45721c09deda8df9dffb38f99cf5f0015b118473d58dd22f558f863583b99"} 15:43:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:43:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:43:54 INFO - Contents: 15:43:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f156844e1587e93536255aac2d7ae86bd1e8a23dd7b7392391993803af1ce071eefdd97e7e6b33cef68486c711f6441134536d963358cea61bb3da8a8a2aad0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b5338e63892534b8da9ec2720b9a28c1496d5940ec1d6b36a595982f119a8c725b5cb1d490f557107e041baf94ba7d9f71d4caf009b8d53e06b2d1b35eb229d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792dcb58041e5469f49551b2e043a01be00155167f4a8ab830653f83bd3441469aa45721c09deda8df9dffb38f99cf5f0015b118473d58dd22f558f863583b99"} 15:43:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:43:54 INFO - Copying logs to upload dir... 15:43:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:43:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.795662 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 15:43:54.172861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 15:43:54.176341) ========= 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=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f156844e1587e93536255aac2d7ae86bd1e8a23dd7b7392391993803af1ce071eefdd97e7e6b33cef68486c711f6441134536d963358cea61bb3da8a8a2aad0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b5338e63892534b8da9ec2720b9a28c1496d5940ec1d6b36a595982f119a8c725b5cb1d490f557107e041baf94ba7d9f71d4caf009b8d53e06b2d1b35eb229d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792dcb58041e5469f49551b2e043a01be00155167f4a8ab830653f83bd3441469aa45721c09deda8df9dffb38f99cf5f0015b118473d58dd22f558f863583b99"} build_url:https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/SSKGS-coSTiTB6jODSgOOQ/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/Firefox-Non-PGO/sha512/8f156844e1587e93536255aac2d7ae86bd1e8a23dd7b7392391993803af1ce071eefdd97e7e6b33cef68486c711f6441134536d963358cea61bb3da8a8a2aad0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b5338e63892534b8da9ec2720b9a28c1496d5940ec1d6b36a595982f119a8c725b5cb1d490f557107e041baf94ba7d9f71d4caf009b8d53e06b2d1b35eb229d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792dcb58041e5469f49551b2e043a01be00155167f4a8ab830653f83bd3441469aa45721c09deda8df9dffb38f99cf5f0015b118473d58dd22f558f863583b99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 15:43:54.201265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:43:54.201578) ========= 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=32c5991c409366f7fec8a718000001d2-1470262734.913955-113830089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 15:43:54.286139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 15:43:54.286442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 15:43:54.286766) ========= ========= Total master_lag: 0.16 =========