builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1460747954.93 results: success (0) buildid: 20160415110147 builduid: 183ae156ad8945b3951829d2cb87ff8b revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:14.927013) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:14.927741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:14.928011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:14.947292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:14.947551) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 12:19:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-04-15 12:19:15 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.034780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.035065) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014087 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.084584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.084891) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 354cb3932e36994d7e772cedba237e9c3c60fe4c --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 354cb3932e36994d7e772cedba237e9c3c60fe4c --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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 12:19:15,255 truncating revision to first 12 chars 2016-04-15 12:19:15,255 Setting DEBUG logging. 2016-04-15 12:19:15,255 attempt 1/10 2016-04-15 12:19:15,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/354cb3932e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 12:19:15,546 unpacking tar archive at: mozilla-central-354cb3932e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.655180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.655462) ========= script_repo_revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.655828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.656112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:19:15.668796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-15 12:19:15.669059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:15 INFO - MultiFileLogger online at 20160415 12:19:15 in /builds/slave/test 12:19:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:19:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:15 INFO - {'append_to_log': False, 12:19:15 INFO - 'base_work_dir': '/builds/slave/test', 12:19:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:19:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:15 INFO - 'branch': 'Firefox-Non-PGO', 12:19:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:15 INFO - 'config_files': ('talos/linux_config.py',), 12:19:15 INFO - 'default_actions': ('clobber', 12:19:15 INFO - 'read-buildbot-config', 12:19:15 INFO - 'download-and-extract', 12:19:15 INFO - 'populate-webroot', 12:19:15 INFO - 'create-virtualenv', 12:19:15 INFO - 'install', 12:19:15 INFO - 'run-tests'), 12:19:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:15 INFO - 'download_minidump_stackwalk': True, 12:19:15 INFO - 'download_symbols': 'ondemand', 12:19:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:15 INFO - 'installer_path': 'installer.exe', 12:19:15 INFO - 'log_level': 'info', 12:19:15 INFO - 'log_name': 'talos', 12:19:15 INFO - 'log_to_console': True, 12:19:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:15 INFO - 'opt_config_files': (), 12:19:15 INFO - 'pip_index': False, 12:19:15 INFO - 'sps_profile': False, 12:19:15 INFO - 'sps_profile_interval': 0, 12:19:15 INFO - 'suite': 'dromaeojs-e10s', 12:19:15 INFO - 'system_bits': '32', 12:19:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:15 INFO - 'title': 'talos-linux64-ix-023', 12:19:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:15 INFO - 'use_talos_json': True, 12:19:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:15 INFO - 'work_dir': 'build'} 12:19:15 INFO - ##### 12:19:15 INFO - ##### Running clobber step. 12:19:15 INFO - ##### 12:19:15 INFO - Running pre-action listener: _resource_record_pre_action 12:19:15 INFO - Running main action method: clobber 12:19:15 INFO - rmtree: /builds/slave/test/build 12:19:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:16 INFO - Running post-action listener: _resource_record_post_action 12:19:16 INFO - ##### 12:19:16 INFO - ##### Running read-buildbot-config step. 12:19:16 INFO - ##### 12:19:16 INFO - Running pre-action listener: _resource_record_pre_action 12:19:16 INFO - Running main action method: read_buildbot_config 12:19:16 INFO - Using buildbot properties: 12:19:16 INFO - { 12:19:16 INFO - "project": "", 12:19:16 INFO - "product": "firefox", 12:19:16 INFO - "script_repo_revision": "production", 12:19:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:19:16 INFO - "repository": "", 12:19:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:19:16 INFO - "buildid": "20160415110147", 12:19:16 INFO - "pgo_build": "False", 12:19:16 INFO - "basedir": "/builds/slave/test", 12:19:16 INFO - "buildnumber": 289, 12:19:16 INFO - "slavename": "talos-linux64-ix-023", 12:19:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:19:16 INFO - "platform": "ubuntu64_hw", 12:19:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:19:16 INFO - "branch": "mozilla-central", 12:19:16 INFO - "repo_path": "mozilla-central", 12:19:16 INFO - "revision": "354cb3932e36994d7e772cedba237e9c3c60fe4c", 12:19:16 INFO - "stage_platform": "linux64", 12:19:16 INFO - "builduid": "183ae156ad8945b3951829d2cb87ff8b", 12:19:16 INFO - "slavebuilddir": "test" 12:19:16 INFO - } 12:19:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:19:16 INFO - Running post-action listener: _resource_record_post_action 12:19:16 INFO - ##### 12:19:16 INFO - ##### Running download-and-extract step. 12:19:16 INFO - ##### 12:19:16 INFO - Running pre-action listener: _resource_record_pre_action 12:19:16 INFO - Running main action method: download_and_extract 12:19:16 INFO - mkdir: /builds/slave/test/build/tests 12:19: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')]} 12:19:16 INFO - https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:19:19 INFO - Downloaded 1361 bytes. 12:19:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:19 INFO - Using the following test package requirements: 12:19:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:19:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'jsshell-linux-x86_64.zip'], 12:19:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:19:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:19:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19:19 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')]} 12:19:19 INFO - https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:21 INFO - Downloaded 22202074 bytes. 12:19:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:19:22 INFO - Return code: 0 12:19:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:19:22 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')]} 12:19:22 INFO - https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:28 INFO - Downloaded 22202074 bytes. 12:19:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:19:29 INFO - Return code: 0 12:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:29 INFO - https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:19:30 INFO - Downloaded 10841076 bytes. 12:19:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:19:30 INFO - Return code: 0 12:19:30 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')]} 12:19:30 INFO - https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:19:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:19:33 INFO - Downloaded 54475087 bytes. 12:19:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:33 INFO - mkdir: /builds/slave/test/properties 12:19:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:33 INFO - Contents: 12:19:33 INFO - build_url:https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:34 INFO - Running post-action listener: _resource_record_post_action 12:19:34 INFO - Running post-action listener: set_extra_try_arguments 12:19:34 INFO - ##### 12:19:34 INFO - ##### Running populate-webroot step. 12:19:34 INFO - ##### 12:19:34 INFO - Running pre-action listener: _resource_record_pre_action 12:19:34 INFO - Running main action method: populate_webroot 12:19:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:34 INFO - '--tppagecycles', 12:19:34 INFO - '7'], 12:19:34 INFO - 'tests': ['tsvgm']}}, 12:19:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['damp', 'tps']}, 12:19:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'tests': ['damp', 'tps']}, 12:19:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['dromaeo_dom']}, 12:19:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['a11yr', 12:19:34 INFO - 'ts_paint', 12:19:34 INFO - 'tpaint', 12:19:34 INFO - 'sessionrestore', 12:19:34 INFO - 'sessionrestore_no_auto_restore', 12:19:34 INFO - 'tabpaint']}, 12:19:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['tsvgx', 12:19:34 INFO - 'tsvgr_opacity', 12:19:34 INFO - 'tart', 12:19:34 INFO - 'tscrollx', 12:19:34 INFO - 'cart']}, 12:19:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:34 INFO - 'tsvgr_opacity', 12:19:34 INFO - 'tart', 12:19:34 INFO - 'tscrollx', 12:19:34 INFO - 'cart']}, 12:19:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'talos_options': ['--disable-e10s'], 12:19:34 INFO - 'tests': ['tp5o']}, 12:19:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'tests': ['tp5o']}, 12:19:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'talos_options': ['--disable-e10s', 12:19:34 INFO - '--xperf_path', 12:19:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:34 INFO - 'tests': ['tp5n']}, 12:19:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:34 INFO - 'talos_options': ['--xperf_path', 12:19:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:34 INFO - 'tests': ['tp5n']}}, 12:19:34 INFO - 'talos.zip': {'path': '', 12:19:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:34 INFO - Running post-action listener: _resource_record_post_action 12:19:34 INFO - ##### 12:19:34 INFO - ##### Running create-virtualenv step. 12:19:34 INFO - ##### 12:19:34 INFO - Running pre-action listener: _resource_record_pre_action 12:19:34 INFO - Running main action method: create_virtualenv 12:19:34 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:34 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 12:19:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:34 INFO - Using real prefix '/usr' 12:19:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:34 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:36 INFO - Installing pip.................done. 12:19:36 INFO - Return code: 0 12:19:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19: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', 'pip>=1.5'] in /builds/slave/test/build 12:19: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 pip>=1.5 12:19:36 INFO - Using env: {'DISPLAY': ':0', 12:19:36 INFO - 'HOME': '/home/cltbld', 12:19:36 INFO - 'LANG': 'en_US.UTF-8', 12:19:36 INFO - 'LANGUAGE': 'en_US:en', 12:19:36 INFO - 'LOGNAME': 'cltbld', 12:19:36 INFO - 'MAIL': '/var/mail/cltbld', 12:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:36 INFO - 'MOZ_NO_REMOTE': '1', 12:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:36 INFO - 'NO_EM_RESTART': '1', 12:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:36 INFO - 'PWD': '/builds/slave/test', 12:19:36 INFO - 'SHELL': '/bin/bash', 12:19:36 INFO - 'SHLVL': '1', 12:19:36 INFO - 'TERM': 'linux', 12:19:36 INFO - 'TMOUT': '86400', 12:19:36 INFO - 'USER': 'cltbld', 12:19:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:36 INFO - '_': '/tools/buildbot/bin/python'} 12:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:36 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 12:19:36 INFO - Cleaning up... 12:19:36 INFO - Return code: 0 12:19:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:19: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 psutil>=0.7.1 12:19:36 INFO - Using env: {'DISPLAY': ':0', 12:19:36 INFO - 'HOME': '/home/cltbld', 12:19:36 INFO - 'LANG': 'en_US.UTF-8', 12:19:36 INFO - 'LANGUAGE': 'en_US:en', 12:19:36 INFO - 'LOGNAME': 'cltbld', 12:19:36 INFO - 'MAIL': '/var/mail/cltbld', 12:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:36 INFO - 'MOZ_NO_REMOTE': '1', 12:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:36 INFO - 'NO_EM_RESTART': '1', 12:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:36 INFO - 'PWD': '/builds/slave/test', 12:19:36 INFO - 'SHELL': '/bin/bash', 12:19:36 INFO - 'SHLVL': '1', 12:19:36 INFO - 'TERM': 'linux', 12:19:36 INFO - 'TMOUT': '86400', 12:19:36 INFO - 'USER': 'cltbld', 12:19:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:36 INFO - '_': '/tools/buildbot/bin/python'} 12:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:37 INFO - Downloading/unpacking psutil>=0.7.1 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:39 INFO - Installing collected packages: psutil 12:19:39 INFO - Running setup.py install for psutil 12:19:39 INFO - building 'psutil._psutil_linux' extension 12:19:39 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 12:19:39 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 12:19:39 INFO - building 'psutil._psutil_posix' extension 12:19:39 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 12:19:39 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 12:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:39 INFO - Successfully installed psutil 12:19:39 INFO - Cleaning up... 12:19:39 INFO - Return code: 0 12:19:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:19:39 INFO - Using env: {'DISPLAY': ':0', 12:19:39 INFO - 'HOME': '/home/cltbld', 12:19:39 INFO - 'LANG': 'en_US.UTF-8', 12:19:39 INFO - 'LANGUAGE': 'en_US:en', 12:19:39 INFO - 'LOGNAME': 'cltbld', 12:19:39 INFO - 'MAIL': '/var/mail/cltbld', 12:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:39 INFO - 'MOZ_NO_REMOTE': '1', 12:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:39 INFO - 'NO_EM_RESTART': '1', 12:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:39 INFO - 'PWD': '/builds/slave/test', 12:19:39 INFO - 'SHELL': '/bin/bash', 12:19:39 INFO - 'SHLVL': '1', 12:19:39 INFO - 'TERM': 'linux', 12:19:39 INFO - 'TMOUT': '86400', 12:19:39 INFO - 'USER': 'cltbld', 12:19:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:39 INFO - '_': '/tools/buildbot/bin/python'} 12:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:19:42 INFO - Installing collected packages: mozsystemmonitor 12:19:42 INFO - Running setup.py install for mozsystemmonitor 12:19:42 INFO - Successfully installed mozsystemmonitor 12:19:42 INFO - Cleaning up... 12:19:42 INFO - Return code: 0 12:19:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:42 INFO - Using env: {'DISPLAY': ':0', 12:19:42 INFO - 'HOME': '/home/cltbld', 12:19:42 INFO - 'LANG': 'en_US.UTF-8', 12:19:42 INFO - 'LANGUAGE': 'en_US:en', 12:19:42 INFO - 'LOGNAME': 'cltbld', 12:19:42 INFO - 'MAIL': '/var/mail/cltbld', 12:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:42 INFO - 'MOZ_NO_REMOTE': '1', 12:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:42 INFO - 'NO_EM_RESTART': '1', 12:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:42 INFO - 'PWD': '/builds/slave/test', 12:19:42 INFO - 'SHELL': '/bin/bash', 12:19:42 INFO - 'SHLVL': '1', 12:19:42 INFO - 'TERM': 'linux', 12:19:42 INFO - 'TMOUT': '86400', 12:19:42 INFO - 'USER': 'cltbld', 12:19:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:42 INFO - '_': '/tools/buildbot/bin/python'} 12:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:45 INFO - Downloading docopt-0.6.1.tar.gz 12:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:45 INFO - Running setup.py install for blobuploader 12:19:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:45 INFO - Running setup.py install for requests 12:19:46 INFO - Running setup.py install for docopt 12:19:46 INFO - Successfully installed blobuploader requests docopt 12:19:46 INFO - Cleaning up... 12:19:46 INFO - Return code: 0 12:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:46 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')]} 12:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:46 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')]} 12:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:46 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 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:46 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 12:19:46 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 12:19:46 INFO - Using env: {'DISPLAY': ':0', 12:19:46 INFO - 'HOME': '/home/cltbld', 12:19:46 INFO - 'LANG': 'en_US.UTF-8', 12:19:46 INFO - 'LANGUAGE': 'en_US:en', 12:19:46 INFO - 'LOGNAME': 'cltbld', 12:19:46 INFO - 'MAIL': '/var/mail/cltbld', 12:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:46 INFO - 'MOZ_NO_REMOTE': '1', 12:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:46 INFO - 'NO_EM_RESTART': '1', 12:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:46 INFO - 'PWD': '/builds/slave/test', 12:19:46 INFO - 'SHELL': '/bin/bash', 12:19:46 INFO - 'SHLVL': '1', 12:19:46 INFO - 'TERM': 'linux', 12:19:46 INFO - 'TMOUT': '86400', 12:19:46 INFO - 'USER': 'cltbld', 12:19:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:46 INFO - '_': '/tools/buildbot/bin/python'} 12:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:46 INFO - Running setup.py (path:/tmp/pip-NIKuZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:46 INFO - Running setup.py (path:/tmp/pip-VYqKU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:46 INFO - Running setup.py (path:/tmp/pip-xGEVAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:46 INFO - Running setup.py (path:/tmp/pip-vJFZhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:46 INFO - Running setup.py (path:/tmp/pip-CONNEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:46 INFO - Running setup.py (path:/tmp/pip-_0rhf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:46 INFO - Running setup.py (path:/tmp/pip-Gw7neH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:46 INFO - Running setup.py (path:/tmp/pip-hYe0aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:46 INFO - Running setup.py (path:/tmp/pip-Vexz8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:47 INFO - Running setup.py (path:/tmp/pip-VO3P6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:47 INFO - Running setup.py (path:/tmp/pip-chQWuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:47 INFO - Running setup.py (path:/tmp/pip-PU7Lsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:47 INFO - Running setup.py (path:/tmp/pip-M74TpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:47 INFO - Running setup.py (path:/tmp/pip-3n4sKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:47 INFO - Running setup.py (path:/tmp/pip-ioOzKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:47 INFO - Running setup.py (path:/tmp/pip-DuIRWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:47 INFO - Running setup.py (path:/tmp/pip-Y6NPsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:47 INFO - Running setup.py install for manifestparser 12:19:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Running setup.py install for mozcrash 12:19:47 INFO - Running setup.py install for mozdebug 12:19:47 INFO - Running setup.py install for mozdevice 12:19:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozfile 12:19:48 INFO - Running setup.py install for mozhttpd 12:19:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozinfo 12:19:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozInstall 12:19:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozleak 12:19:48 INFO - Running setup.py install for mozlog 12:19:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for moznetwork 12:19:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozprocess 12:19:48 INFO - Running setup.py install for mozprofile 12:19:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:48 INFO - Running setup.py install for mozrunner 12:19:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:49 INFO - Running setup.py install for mozscreenshot 12:19:49 INFO - Running setup.py install for moztest 12:19:49 INFO - Running setup.py install for mozversion 12:19:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:49 INFO - Cleaning up... 12:19:49 INFO - Return code: 0 12:19:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 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 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:49 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 12:19:49 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 12:19:49 INFO - Using env: {'DISPLAY': ':0', 12:19:49 INFO - 'HOME': '/home/cltbld', 12:19:49 INFO - 'LANG': 'en_US.UTF-8', 12:19:49 INFO - 'LANGUAGE': 'en_US:en', 12:19:49 INFO - 'LOGNAME': 'cltbld', 12:19:49 INFO - 'MAIL': '/var/mail/cltbld', 12:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:49 INFO - 'MOZ_NO_REMOTE': '1', 12:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:49 INFO - 'NO_EM_RESTART': '1', 12:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:49 INFO - 'PWD': '/builds/slave/test', 12:19:49 INFO - 'SHELL': '/bin/bash', 12:19:49 INFO - 'SHLVL': '1', 12:19:49 INFO - 'TERM': 'linux', 12:19:49 INFO - 'TMOUT': '86400', 12:19:49 INFO - 'USER': 'cltbld', 12:19:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:49 INFO - '_': '/tools/buildbot/bin/python'} 12:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:49 INFO - Running setup.py (path:/tmp/pip-y7kx_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:49 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)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:49 INFO - Running setup.py (path:/tmp/pip-Tu8Hst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:49 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)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:49 INFO - Running setup.py (path:/tmp/pip-sMv3kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:49 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)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:49 INFO - Running setup.py (path:/tmp/pip-uC1izo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:49 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)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:49 INFO - Running setup.py (path:/tmp/pip-RPi5qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:50 INFO - Running setup.py (path:/tmp/pip-azay7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:50 INFO - Running setup.py (path:/tmp/pip-PkLKR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:50 INFO - Running setup.py (path:/tmp/pip-pAY8_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:50 INFO - Running setup.py (path:/tmp/pip-qnPAqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:50 INFO - Running setup.py (path:/tmp/pip-kJNvPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:50 INFO - Running setup.py (path:/tmp/pip-f7pgBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:50 INFO - Running setup.py (path:/tmp/pip-loSiTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:50 INFO - Running setup.py (path:/tmp/pip-9vrgwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:50 INFO - Running setup.py (path:/tmp/pip-Qv4x8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:50 INFO - Running setup.py (path:/tmp/pip-m3KGtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:50 INFO - Running setup.py (path:/tmp/pip-3Bwnlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:50 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)) 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:50 INFO - Running setup.py (path:/tmp/pip-CXa7_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:50 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)) 12:19:50 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)) 12:19:50 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)) 12:19:50 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)) 12:19:50 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)) 12:19:50 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)) 12:19:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:52 INFO - Downloading blessings-1.6.tar.gz 12:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:52 INFO - Installing collected packages: blessings 12:19:52 INFO - Running setup.py install for blessings 12:19:52 INFO - Successfully installed blessings 12:19:52 INFO - Cleaning up... 12:19:52 INFO - Return code: 0 12:19:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:53 INFO - Reading from file tmpfile_stdout 12:19:53 INFO - Current package versions: 12:19:53 INFO - argparse == 1.2.1 12:19:53 INFO - blessings == 1.6 12:19:53 INFO - blobuploader == 1.2.4 12:19:53 INFO - docopt == 0.6.1 12:19:53 INFO - manifestparser == 1.1 12:19:53 INFO - mozInstall == 1.12 12:19:53 INFO - mozcrash == 0.17 12:19:53 INFO - mozdebug == 0.1 12:19:53 INFO - mozdevice == 0.48 12:19:53 INFO - mozfile == 1.2 12:19:53 INFO - mozhttpd == 0.7 12:19:53 INFO - mozinfo == 0.9 12:19:53 INFO - mozleak == 0.1 12:19:53 INFO - mozlog == 3.1 12:19:53 INFO - moznetwork == 0.27 12:19:53 INFO - mozprocess == 0.22 12:19:53 INFO - mozprofile == 0.28 12:19:53 INFO - mozrunner == 6.11 12:19:53 INFO - mozscreenshot == 0.1 12:19:53 INFO - mozsystemmonitor == 0.0 12:19:53 INFO - moztest == 0.7 12:19:53 INFO - mozversion == 1.4 12:19:53 INFO - psutil == 3.1.1 12:19:53 INFO - requests == 1.2.3 12:19:53 INFO - wsgiref == 0.1.2 12:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 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 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:53 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 12:19:53 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 12:19:53 INFO - Using env: {'DISPLAY': ':0', 12:19:53 INFO - 'HOME': '/home/cltbld', 12:19:53 INFO - 'LANG': 'en_US.UTF-8', 12:19:53 INFO - 'LANGUAGE': 'en_US:en', 12:19:53 INFO - 'LOGNAME': 'cltbld', 12:19:53 INFO - 'MAIL': '/var/mail/cltbld', 12:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:53 INFO - 'MOZ_NO_REMOTE': '1', 12:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:53 INFO - 'NO_EM_RESTART': '1', 12:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:53 INFO - 'PWD': '/builds/slave/test', 12:19:53 INFO - 'SHELL': '/bin/bash', 12:19:53 INFO - 'SHLVL': '1', 12:19:53 INFO - 'TERM': 'linux', 12:19:53 INFO - 'TMOUT': '86400', 12:19:53 INFO - 'USER': 'cltbld', 12:19:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:53 INFO - '_': '/tools/buildbot/bin/python'} 12:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 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)) 12:19:53 INFO - Cleaning up... 12:19:53 INFO - Return code: 0 12:19:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:53 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 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:53 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 12:19:53 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 12:19:53 INFO - Using env: {'DISPLAY': ':0', 12:19:53 INFO - 'HOME': '/home/cltbld', 12:19:53 INFO - 'LANG': 'en_US.UTF-8', 12:19:53 INFO - 'LANGUAGE': 'en_US:en', 12:19:53 INFO - 'LOGNAME': 'cltbld', 12:19:53 INFO - 'MAIL': '/var/mail/cltbld', 12:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:53 INFO - 'MOZ_NO_REMOTE': '1', 12:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:53 INFO - 'NO_EM_RESTART': '1', 12:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:53 INFO - 'PWD': '/builds/slave/test', 12:19:53 INFO - 'SHELL': '/bin/bash', 12:19:53 INFO - 'SHLVL': '1', 12:19:53 INFO - 'TERM': 'linux', 12:19:53 INFO - 'TMOUT': '86400', 12:19:53 INFO - 'USER': 'cltbld', 12:19:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:53 INFO - '_': '/tools/buildbot/bin/python'} 12:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:53 INFO - Downloading/unpacking jsonschema 12:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:55 INFO - Downloading/unpacking functools32 (from jsonschema) 12:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:55 INFO - warning: no files found matching '*.txt' 12:19:55 INFO - no previously-included directories found matching 'build' 12:19:55 INFO - no previously-included directories found matching 'dist' 12:19:55 INFO - no previously-included directories found matching '.git*' 12:19:55 INFO - Installing collected packages: jsonschema, functools32 12:19:55 INFO - Running setup.py install for functools32 12:19:55 INFO - warning: no files found matching '*.txt' 12:19:55 INFO - no previously-included directories found matching 'build' 12:19:55 INFO - no previously-included directories found matching 'dist' 12:19:55 INFO - no previously-included directories found matching '.git*' 12:19:55 INFO - Successfully installed jsonschema functools32 12:19:55 INFO - Cleaning up... 12:19:55 INFO - Return code: 0 12:19:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:19:55 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')]} 12:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:55 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')]} 12:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:55 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6520199f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', '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 12:19:55 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', 'flake8'] in /builds/slave/test/build 12:19:55 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 flake8 12:19:55 INFO - Using env: {'DISPLAY': ':0', 12:19:55 INFO - 'HOME': '/home/cltbld', 12:19:55 INFO - 'LANG': 'en_US.UTF-8', 12:19:55 INFO - 'LANGUAGE': 'en_US:en', 12:19:55 INFO - 'LOGNAME': 'cltbld', 12:19:55 INFO - 'MAIL': '/var/mail/cltbld', 12:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:55 INFO - 'MOZ_NO_REMOTE': '1', 12:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:55 INFO - 'NO_EM_RESTART': '1', 12:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:55 INFO - 'PWD': '/builds/slave/test', 12:19:55 INFO - 'SHELL': '/bin/bash', 12:19:55 INFO - 'SHLVL': '1', 12:19:55 INFO - 'TERM': 'linux', 12:19:55 INFO - 'TMOUT': '86400', 12:19:55 INFO - 'USER': 'cltbld', 12:19:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:55 INFO - '_': '/tools/buildbot/bin/python'} 12:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:56 INFO - Downloading/unpacking flake8 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:56 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 12:19:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:19:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:19:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:19:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:58 INFO - no previously-included directories found matching 'docs/_build' 12:19:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:19:58 INFO - Running setup.py install for pep8 12:19:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:58 INFO - no previously-included directories found matching 'docs/_build' 12:19:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:19:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:19:58 INFO - Cleaning up... 12:19:59 INFO - Return code: 0 12:19:59 INFO - Running post-action listener: _resource_record_post_action 12:19:59 INFO - Running post-action listener: _start_resource_monitoring 12:19:59 INFO - Starting resource monitoring. 12:19:59 INFO - ##### 12:19:59 INFO - ##### Running install step. 12:19:59 INFO - ##### 12:19:59 INFO - Running pre-action listener: _resource_record_pre_action 12:19:59 INFO - Running main action method: install 12:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:59 INFO - Reading from file tmpfile_stdout 12:19:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:59 INFO - Reading from file tmpfile_stdout 12:19:59 INFO - Output received: 12:19:59 INFO - Usage: mozinstall [options] installer 12:19:59 INFO - Options: 12:19:59 INFO - -h, --help show this help message and exit 12:19:59 INFO - -d DEST, --destination=DEST 12:19:59 INFO - Directory to install application into. [default: 12:19:59 INFO - "/builds/slave/test"] 12:19:59 INFO - --app=APP Application being installed. [default: firefox] 12:19:59 INFO - mkdir: /builds/slave/test/build/application 12:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:20:14 INFO - Reading from file tmpfile_stdout 12:20:15 INFO - Output received: 12:20:15 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:15 INFO - Running post-action listener: _resource_record_post_action 12:20:15 INFO - ##### 12:20:15 INFO - ##### Running run-tests step. 12:20:15 INFO - ##### 12:20:15 INFO - Running pre-action listener: _resource_record_pre_action 12:20:15 INFO - Running main action method: run_tests 12:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:15 INFO - Python 2.7.3 12:20:15 INFO - Return code: 0 12:20:15 INFO - grabbing minidump binary from tooltool 12:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:15 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8c410>, '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 0x1b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:15 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 12:20:15 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 12:20:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:15 INFO - Return code: 0 12:20:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:20:16 INFO - Return code: 0 12:20:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:20:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:20:16 INFO - Using env: {'DISPLAY': ':0', 12:20:16 INFO - 'HOME': '/home/cltbld', 12:20:16 INFO - 'LANG': 'en_US.UTF-8', 12:20:16 INFO - 'LANGUAGE': 'en_US:en', 12:20:16 INFO - 'LOGNAME': 'cltbld', 12:20:16 INFO - 'MAIL': '/var/mail/cltbld', 12:20:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:16 INFO - 'MOZ_NO_REMOTE': '1', 12:20:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:16 INFO - 'NO_EM_RESTART': '1', 12:20:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:16 INFO - 'PWD': '/builds/slave/test', 12:20:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:16 INFO - 'SHELL': '/bin/bash', 12:20:16 INFO - 'SHLVL': '1', 12:20:16 INFO - 'TERM': 'linux', 12:20:16 INFO - 'TMOUT': '86400', 12:20:16 INFO - 'USER': 'cltbld', 12:20:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251', 12:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:16 INFO - '_': '/tools/buildbot/bin/python'} 12:20:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:20:16 INFO - mozversion application_buildid: 20160415110147 12:20:16 INFO - mozversion application_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 12:20:16 INFO - mozversion application_display_name: Nightly 12:20:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:16 INFO - mozversion application_name: Firefox 12:20:16 INFO - mozversion application_remotingname: firefox 12:20:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:20:16 INFO - mozversion application_vendor: Mozilla 12:20:16 INFO - mozversion application_version: 48.0a1 12:20:16 INFO - mozversion platform_buildid: 20160415110147 12:20:16 INFO - mozversion platform_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 12:20:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:20:16 INFO - mozversion platform_version: 48.0a1 12:20:16 INFO - using testdate: 1460748016 12:20:16 INFO - actual date: 1460748016 12:20:16 INFO - starting webserver on 'localhost:55764' 12:20:16 INFO - SUITE-START | Running 2 tests 12:20:16 INFO - TEST-START | dromaeo_css 12:20:16 INFO - operating with platform_type : linux_ 12:20:16 INFO - Initialising browser for dromaeo_css test... 12:20:16 INFO - TEST-INFO | started process 8318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp97bXmx/profile http://localhost:55764/getInfo.html) 12:20:20 INFO - PROCESS | 8318 | 12:20:20 INFO - PROCESS | 8318 | (process:8388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:20 INFO - PROCESS | 8318 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:20:21 INFO - PROCESS | 8318 | __metrics Screen width/height:1600/1200 12:20:21 INFO - PROCESS | 8318 | colorDepth:24 12:20:21 INFO - PROCESS | 8318 | Browser inner width/height: 1024/697 12:20:21 INFO - PROCESS | 8318 | __metrics 12:20:21 ERROR - PROCESS | 8318 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:20:22 INFO - TEST-INFO | 8318: exit 0 12:20:22 INFO - Browser initialized. 12:20:22 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:22 INFO - TEST-INFO | started process 8439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp97bXmx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:24 INFO - PROCESS | 8439 | 12:20:24 INFO - PROCESS | 8439 | (process:8497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:20:34 INFO - PROCESS | 8439 | RSS: Main: 165400576 12:20:34 INFO - PROCESS | 8439 | 12:21:24 INFO - PROCESS | 8439 | 1460748084176 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] 12:23:36 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55764/tests/dromaeo/cssquery-ext.html) 12:23:37 INFO - PROCESS | 8439 | RSS: Main: 168808448 12:23:37 INFO - PROCESS | 8439 | 12:26:39 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-ext.html (next: http://localhost:55764/tests/dromaeo/cssquery-jquery.html) 12:26:40 INFO - PROCESS | 8439 | RSS: Main: 165408768 12:26:40 INFO - PROCESS | 8439 | 12:29:41 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55764/tests/dromaeo/cssquery-mootools.html) 12:29:42 INFO - PROCESS | 8439 | RSS: Main: 166752256 12:29:42 INFO - PROCESS | 8439 | 12:32:44 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55764/tests/dromaeo/cssquery-prototype.html) 12:32:45 INFO - PROCESS | 8439 | RSS: Main: 164655104 12:32:45 INFO - PROCESS | 8439 | 12:35:47 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55764/tests/dromaeo/cssquery-yui.html) 12:35:48 INFO - PROCESS | 8439 | RSS: Main: 165695488 12:35:48 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | Cycle 1(1): loaded http://localhost:55764/tests/dromaeo/cssquery-yui.html (next: http://localhost:55764/tests/dromaeo/cssquery-dojo.html) 12:38:50 INFO - PROCESS | 8439 | RSS: Main: 167706624 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | __start_tp_report 12:38:50 INFO - PROCESS | 8439 | _x_x_mozilla_page_load 12:38:50 INFO - PROCESS | 8439 | _x_x_mozilla_page_load_details 12:38:50 INFO - PROCESS | 8439 | |i|pagename|runs| 12:38:50 INFO - PROCESS | 8439 | |0;dojo.html;2592.7925765938726;2672.4788666210097;2688.7311268873104;2706.9458610827774;2710.146303914267;4660.231061874791;4694.507076756939;4705.835295764649;4722.220833562458;4748.406449193851;4629.074185162964;4656.371389862367;4717.669763116583;4728.621710263179;4764.928526072112;4283.036316828712;4341.435613370273;4345.348197770344;4347.630451411634;4401.163778882018;4388.956110438902;4423.358613001113;4429.5348988356245;4434.312681534368;4490.438695163105;4211.241976444254;4322.675799315064;4399.12017596482;4412.646988240933;4416.53626369233;4285.914281714348;4294.7423154610515;4300.935485967713;4330.978345108254;4331.805068771912;4185.351270553038;4264.23243816113;4275.636570891478;4276.294411422112;4317.848875289381;4575.084983003379;4624.745638989854;4642.117997580483;4681.882952926204;4695.694779839299;5063.0380227756605;5074.568661663763;5091.9236211456855;5103.362079740033;5107.3360463139925;4863.586595139417;4942.5304596063315;5074.188129899198;5092.439831618519;5147.794088236466;4721.055788842245;4723.937114149323;4732.1009008289;4740.1230772307235;4795.832145874878;5128.743562821844;5179.559737422362;5186.766595503136;5208.661437006583;5215;4768.737719425396;4910.754462276872;4988.127077761377;4999.65002449825;5044.899102017939;4933.753312334369;5022.89954200914;5074.847754567369;5106.565941894981;5124.56441202502;4980.028894365564;4982.377202849644;4985.326980857538;5006.249062640633;5058.013687331008;4824.734639594786;4926.359573255454;4946.08497427977;4964.801407943642;5000.424951130666;4217.8523751668545;4254.829806807755;4269.466316710411;4313.741175529478;4320.4383430153875;3683.4552379249985;3704.7221458390727;3719.6094410087094;3760.6615404613717;3772.1889793694486;4248.830046798155;4329.826806927751;4336.783160842008;4356.390105385249;4400.581944715247;5047.848564543069;5084.339035925306;5096.592272618182;5096.847094587169;5149.098907691214;4367.519572846984;4373.037931655031;4382.499962547046;4398.164348773723;4411.316245981878;4469.307257375047;4495.033567782877;4562.589366956923;4582.450105987303;4612.60792832613;4809.038192361541;4810.254410566367;4818.277258411266;4819.349387832738;4828.7102773833685;5088.236764485208;5099.482690012026;5114.8977020460125;5116.539511443988;5123.154679477844;4586.1057093866375;4716.221823399238;4799.808007679654;4807.134715751198;4812.181929071996;4886.926696099633;4905.337779399878;4936.136176169228;4940.950590494049;4985.177445721415;4905.166121759381;5035.244713293036;5060.367454068241;5076.238564215398;5123.026624941249;4745.217039188496;4825.30033145199;4854.854354369375;4918.139325617931;4956.083124621957;4806.49531799156;4841.709497430165;4851.611871050378;4870.537298956593;4969.279454479008;4644.23370143936;4820.204666230173;4832.855014349575;4840.661153719206;4857.757112144449;4798.856034318976;4833.709977401367;4840.830570930141;4844.370231869834;4849.07867505187;4680.929786053144;4801.255805350176;4879.658423910292;4882.6084565898545;4924.113659541317 12:38:50 INFO - PROCESS | 8439 | |1;ext.html;542.3383472163958;596.4482853360641;613.9631622102672;615.2371059885743;649.4252586460981;31860.20349491264;33114.17214569637;33128;33165.66834331659;33173.50239746406;33944.66055339446;34147.65852341476;34353.48469772955;34438.31123377537;34544.30911381771;7456.88814667779;7647.50291231071;7648.0822301323915;7648.923510764905;7658.9617051914665;7478.401727861785;7676.46264761467;7729.8067548311465;7734.988902885262;7780.416468764837;7727.304542591166;7794.571298578604;7818.218178182193;7828.647710852997;7836;7738.883916741253;7788.844223115534;7804.921950780476;7806.726764563241;7809.921900780976;7707.614619269014;7816.72641457552;7817.530948143073;7826.647800848918;7827.295543401065;28697.426051479062;34859.30281394358;34903.4764478533;35315.82342088299;35516.46725299123;2991.5213565829363;3109.9378012439624;3186.5256623257583;3204.3431096625136;3272.2473831018997;26808.59787103195;27558.724412755815;27835.304117397023;28256.576151357745;28445.431091378057;3367.1245476176127;3390.69483746464;3467.6185619581825;3583.2475180211927;3608;184908;188007;188820;188932.0553397238;189387;33967.4904876427;35058.59765609347;35103;56287.43712562904;57644.42355576474;33411.83294083563;33429.3314133716;33587.66412335894;33611;33784.32431351408;12333.50665973369;12499.750004999849;12504.937475312565;12533.498660053678;12543;10985.61550345734;11071.335719856834;11071.501782419811;11078.947499987487;11092.057175140204;8267.173282671685;8385.077641459435;8455.323574114056;8460.534670593177;8462.534560599102;3302.2734998300816;3319.668033196661;3341.2482191506715;3350.69843714062;3401;948.2887834124407;982.6511588386163;1004.4726518577659;1007.8387458006683;1029.1663752360612;28518.429631407256;28631.856840715664;28754.281142971595;28809.71190288112;28986.565201521993;973.8052389522123;1026.7381817636456;1087.6302057300556;1135.2280449294394;1151.3955173533961;14857.925710371379;15375.692486150214;15431.768523472158;15514.689706205812;15615.843841561666;354215;363599;366961;368401;369485;49215.26177107346;50001;50121.24818127731;50204.748976255614;50324.72889262186;1172.9061675065975;1226.3929354969348;1275.0564582209283;1278.0733967873218;1285.0747461827468;26482.86758566195;27766.44467110687;28003.299917502227;28291.151265462067;28330.575041374806;42575;42931.7853410731;43158.35262471002;43160.13679726451;43193.3520997179;334749;336191;337091;337196;337797;25747.871260643577;26043.739562604133;26148;26270.73729262683;26771.86614066917;41279.174416512105;42028.57971420247;42539.51111711075;42589;42607.147857042066;35668.643313566536;36007.63992360043;36450;36574.268514630094;36959.44560831536;34624.134396640286;35124.648753512134;35139.47290790589;35627.10932226715;35783.82108089443;31963.611671426166;34566.13584660403;34631;35814;36090.819545903156;28428.85785571059;30504.237394065327;31064.844675776476;31118.377632446773;31165.532517012718;24195.879020604785;24291.514169716862;24773.876130619232;24836.37909052288;25069.87465062663 12:38:50 INFO - PROCESS | 8439 | |2;jquery.html;382.1001541370073;382.37481717392075;392.3604524624861;392.621120618603;397.46937837986286;13178.341082945863;15798.210089495522;16052.919735401307;17687.734683979736;17731.290748370066;16336.264868080934;16933.83066169338;16979.49061528153;17050.317987280494;17453.214605342757;4943.6539442239055;5072.9746351268195;5214.348206474191;5225;5229.08491014071;5065.594752419816;5114.411842638088;5131.666441681297;5189.273501709764;5189.558887494568;4901.558859702626;5064.189729643258;5070.163423035213;5099.541041306282;5214.556762675177;5173.793048278064;5194.532492075694;5196.68819870809;5204.531592156705;5227.4511176326505;4497.460304763416;4600.700954437951;4669.929951050737;4673.836415725434;4692.507286734912;20045.699314510293;20330.288439904532;20370.796292037037;20523.281685140948;20757;1875.831175194239;2008.1365013044385;2030.614183305182;2244.4276709438986;2377.941815891929;13188.736225275537;13331.933340333333;13387.799183012263;13405.66485837852;13721.245331506763;1786.8749187556875;1792.865535084874;1851.8333349998566;1866.5986812835306;1868.5982513759607;67565.66217168931;68080;68336;68508.6574567129;68608;8521.488710677379;8953.820923581492;9569.138777510057;9679.419234845931;9738.123568878835;11381.943090284496;11862.347570883685;12858.807117893239;12864;12881.935590321988;6651.833704157338;6804.9319506804295;7012.474064445187;7093.397061249749;7281.308275713799;6633.568818026813;6645.568038077607;6657.667116644148;6769.966150169218;6773.8645227095185;5770.88458230833;5909.8227053188475;5974.386915532782;6011.3086994995265;6080.817575472743;1701.157926826229;1739.4259894234872;1776.1740790532465;1807.0242069282704;1825.2242796811302;799.4683535448861;819.8524265632124;827.8758186271987;863.7883718488885;869.3306154261184;14528.273586320642;14925.776113358308;15002.69994600102;15088.24558772057;15184.164870932205;809.287826712501;818.3289702443939;830.7507747675673;833.2875391540267;841.1798496465897;6357.427831495188;8323.583820808935;8472.279856212292;8667.739967800977;8672.523011234316;392119;393012;402823;404403;410476;43696;69671.3032869675;71411.64294178496;72704;81362;967.1295833749682;969.762408209993;984.7931934293736;996.3822430093388;998.7902540466438;13275.137116087424;13310.733785324433;13678.726425471235;13692.31538423055;13742.793858092336;30875.228119297197;31571.36857262888;31833.522497163023;33506.497402538494;33876.83061584775;40014.39978400268;40340.1931961365;40677;41485.37771933363;45328.77335613301;5143.459936706592;6899.103116594811;7482.476226664081;7638.961805190938;7772.727954521564;10167.644132455329;11245.831312530483;11252.718682033015;11489.138314626269;12036.097292702907;10161.187105031728;10233;10311.329763565343;10430.426326552113;10513.476765576359;10447.320924139907;10469;10493.632722854663;10567.682969510619;10775.838362424412;10063.547140378554;10321.277510574188;10413.479326033517;10684.198685098803;11007.284526505751;7797.805054873674;7879.645415956181;7896.921030789618;7906.446548741533;7908.881366779618;8076.959615201887;9651.9034809651;10788.514516846604;10899.237053406185;11064.612738554433 12:38:50 INFO - PROCESS | 8439 | |3;mootools.html;1439.9352029158688;1470.94827198553;1595.64895722941;1764.7352897065446;1814.1745505794865;6908.20555636102;7431.405487560995;7667.654955527;7767.6892924282965;7801.960990195048;7627.199144089874;7664.310212080912;7665;7705.807354816133;7716.996790417238;2259.559385919742;2290.1640901071155;2295.7819007194375;2296.3570200343847;2306.4925716342377;2243.842930994831;2252.774722527742;2273.7385200701965;2276.590213761522;2278.0773786616446;2247.4718441166315;2249.6737972993906;2250.1561914282142;2266.660000999847;2279.0883646541433;2170.338046895696;2185.4754858833926;2186.868787872733;2187.9671804922937;2187.9781202188015;2224.5217278285245;2269.863808171515;2276.430892276931;2282.9086836526685;2284.4859906521065;7936.920630793676;7948.125706172316;7951.443398962075;8011.439199256054;8023.799405014863;4734.881627959294;4890.584300334476;4917.680350777188;4926.433460152092;4946.9010619787405;2845.445138198052;2850.230437781808;2853.5149024665857;2857.00004998251;2884.379858330448;924.8057907839362;946.8248374050754;965.5365424596163;976.4092723902008;978.1099199728284;10696.572137114506;10730.517126729315;10736.463176841127;10756;10779.78440431187;4313.913721725611;4340.500842403101;4471.977640111843;4526.569975852289;4535.138323718483;9159;9182.127697868691;9194.264458843276;9209.769755756026;9234.261259099256;4629.699069560468;4659.930101048487;4682.41469816273;4684.672072954929;4710.317004034396;3791.1659434924272;4209.2423363794815;4219.0507135894795;4275.230458517434;4389.956100439019;3646.7082633389264;3663.87176448823;3689.1330537323706;3722.813859307024;3772.2078363543415;1244.502199120341;1256.723520825417;1262.9873701263054;1269.435101379877;1288.7486940046788;752.4920678541962;781.3827076609415;867.8134201146657;909.6543313540813;920.6179435534178;5380.757865896044;5571.609987300931;5688.914666280009;5779.711014449261;5828.88342233153;875.9737207883774;972.4457059476172;992.270681049428;1011.8735158105237;1020.3826684855704;3633.291508155884;3807.4098514730263;3872.0513474198438;3908.5309762828074;3940.2119576084897;9444.90555094454;9738.659146929966;9824.607015719434;9846.901530984598;9882.950585247172;9612.18296444796;9637.855432168522;9640.228781697448;9749.415035097916;9791.020897910294;6903.137107861618;7394.815129621803;7505.286997735207;7547.73582924595;7552.169261381244;5697.088465845445;5699.373068962494;5737.196792448977;5757.050086735641;5763.7118144093465;8942.46345219289;8965.103489650983;9040;9047.095290470901;9142.131497507726;8323.916760832557;8770.166834150745;8800.471971681463;8805.691800787197;8806.823863522823;5993.280806303272;6650;6668.466522678271;6799.796006119825;6855.07456493367;7203.279672032755;7217.386522145676;7300.196978332486;7308.415326773739;7330.193678695233;6484.578502397329;6721.092652491851;6751;6766.255711871789;6804.863902722017;6610.405063544112;6613.305602911817;6763.323667633197;6827.283135270725;6861.897071543831;6449.419552240321;6484.092227088306;6499.935000649933;6561.081448597296;6568.146141001639;4805.327254184487;4890.510948905081;4909.091818013536;4927.581155601671;4940.431850337257;4806.134895718804;4807.807687692593;4842.031593681349;4897.069556784199;4947.554720075211 12:38:50 INFO - PROCESS | 8439 | |4;prototype.html;312.6014331727048;315.6622414017002;321.8246055899535;322.2652352635991;324.62505805794285;5325.733713314334;5327.653702509339;5374.032674118657;5382.730863456822;5384.434634363394;5289.947100528993;5301.814436494724;5313.654612450188;5331.733413329328;5336.359636843575;3886.514185726777;3999.4200840878057;4092.774897380643;4144.502659680843;4177.122804211104;4142.212979533879;4154.626083652471;4161.9375709364385;4162.125953549758;4180.184863951531;4113.938290925638;4129.958700413003;4133.9173216535655;4137.793110344471;4146.730462519927;4031.7782521961426;4084.7549147051272;4092.4270602115726;4107.774072426016;4110.28070087735;3600.819959002066;3601.2977469393477;3601.5678118625933;3617.2042150726797;3620.746547741659;5082;5105.412877519096;5118.820841270538;5119.334486516729;5135.74321283938;4566.429196350457;4753.786079626425;4764.404449443819;4764.97553026101;4765.666403351766;5587.636803607753;5598.384177740445;5599.804006859781;5605.523530499912;5632.324121105453;3934.8426062957733;3956.4658771065824;3959.3269144245546;3968.444417781513;3968.5436174839974;5556.91664625031;5913.142594323799;5924.763009479616;5935.2877654681715;5942.821715348547;3945.822437990297;3977.661898738582;3986.740861843971;3991.5409727881083;4001.579834117434;4051.331530297527;4054.2904991626347;4058.2086493134148;4065.10567675111;4078.5513593504693;4603.838865639686;4671.392718946515;4673.556012178838;4683.695559788603;4686.6485013624115;5651.095824668033;5659.5755318351285;5663.329317851244;5667;5670.5463562914865;1393.7769956806862;1408.0777091005407;1408.1832537128441;1409.9154050756988;1413.8303403591428;875.2166810704384;902.6479672927563;938.6855403439788;959.7072892767773;960.9951950240204;4809.615230781529;4821.975890120527;4827.879303017453;4834.564889159992;4859.368282123372;5719.227904232958;5746.741396637161;5748.223989761329;5761.135829625506;5766.481016708516;4655.51117132703;4783.210770222874;4817.2774083887;4820.855374338776;4906.018796240766;3116.407882502317;3125.46867032605;3145.433821912032;3146;3149.921251968719;5468.7265636718;5486.1222204447895;5489.560835133179;5495.725213739377;5498.5876059295715;5852.795152169653;5914.9187060927825;5948.732307046107;5981.581289309794;5987.101934709828;5422.861199148223;5453.700046497481;5458.645188062763;5483.533899618577;5513.649155956736;5639.182318563868;5836.445537673914;5839.386864379179;5847;5859.326177489644;5730.312362516524;5736.852629474039;5739.2252045973255;5753.884922301614;5758.827235182951;5470.589705772003;5473.72631368422;5476.288082549243;5496.340439147328;5516.365617953827;3928.4303775951757;3939.862104826317;3967.4247234150307;4007.1985602880122;4020.7587544747407;5801.506871915765;5818.389069147848;5823.534117270693;5851.385604511635;5869.853253668693;5597.3003374578175;5613.456299517502;5644.717764111696;5657.349404818498;5667.914981275367;5487.052096505683;5583.2462617547735;5619.943800561942;5636.605437619327;5637.46444087811;5247.02929957959;5521.365043019943;5526.226328313959;5548.417416171405;5552.444755524415;5439.782408703608;5662.716864156693;5667.943320566742;5676.318841739017;5688.431156884279;5524.530414914777;5543.52880005204;5550.361708403585;5555.666660000413;5579.609427340048 12:38:50 INFO - PROCESS | 8439 | |5;yui.html;713.5932518464477;736.561745761272;769.3460558525253;781.3788038509388;786.6027656033702;11398.829017564733;11603.303801771879;11628.360440175788;11664.883351166485;11669.883301166985;11236.66290011299;11309.943450282757;11963.521459141646;12583;12625.305608191546;803.1887793328722;805.697863301262;807.8263173417714;808.3613944983456;810.6959890041235;641.6086187425667;794.0947320055113;800.1358532784578;801.7193982106245;807.9798005049892;841.8148007438384;844.3034496540348;846.2510678049908;850.1286181663783;850.4387104511025;830.5930094253832;838.1074156023815;839.7858546070744;840.6637345061963;841.4530555139147;610.3957082488305;611.7552978808512;613.1048668943348;613.2457077794294;613.6011592464889;11609.709757256052;11634;11679.065674746085;12126.211796233305;12133.878661213363;12917.354132293347;13097.148685335518;13124.803127953088;13149.342532873414;13473.797893031613;10135.543900524493;10241.436720980342;10284.845727314021;10291.331063480924;10404.063634272876;3333.749968752329;3367.2087059540986;3389.2713066690535;3392.23674673199;3472.73954453417;47807.760961195316;48110.759446202894;48236.517634823904;48254;48261.75869120632;10289.713785776778;10387;10439.321444106108;10544.314619549705;10645;18070.457886263433;18211.362602308855;18416.079196040144;18469.7229541557;18524.44426667202;7283.635818209068;7356.632168391559;7416.555006699507;7431.405487560982;7463.14173870001;3893.260280546687;3952.9011774705864;3996.9200615987515;4014.2573623879093;4027.436158937751;2869.6126022986628;2947.3073827650487;2949.277427030391;2950.247686839842;2966.5846781450614;544.8801263721975;560.344397055438;560.6215804332141;561.9213310136585;595.7459547652217;580.9273840769904;594.088074805172;610.4444955090935;625.3902445115975;647.1910112359551;7959.787579582944;8037.316828069563;8042.195780421911;8146.389020823462;8575.699850505327;501.99600798403196;537.3739593373676;583.2184872271177;635.7266375458597;650.3756393861851;3976.5824588418377;4006.0185254612807;4048.757074575476;4133.483314585676;4234.237837189336;57428;57497.712511437174;58120.709396452745;58340;58392.416075839545;49120;49852.25221621679;49863.252051219264;50517.49482505128;50954;45925.54074459212;45983.77008114938;46072.539274606825;46174.769126154824;46752.5324746755;7659.272369124924;7728.690852366068;7788.571628560484;7891.013623297088;7946.205379462239;29206.853965730035;30077;30433.23916902095;30778.53832192474;30902.22744431407;37406;40999;41487;41592.37611435771;42189;9770.951145244513;9897.703068907944;9903;10098.495075246356;10438.269321147447;10149.39103653783;10187.643432479828;10467.214958877963;10539.367637941748;10608;10021.198304135505;10173.593056277961;10214.336068155546;10218.846717299099;10265.384076955406;10251.948740256252;10278.25380630227;10408.531616077446;10525.36847789135;10606.681799546026;9775.364601300893;9862.852057219005;9950.651727189514;9964.55159517838;10290.588376464857;8378.455400398954;8402.831943360976;8697.217250447236;8732.170443807829;8886.688965886164;8848.292136629183;8909.465432074096;9024.684136055206;9036.096390360912;9243.352965292364 12:38:50 INFO - PROCESS | 8439 | __end_tp_report 12:38:50 INFO - PROCESS | 8439 | __start_cc_report 12:38:50 INFO - PROCESS | 8439 | _x_x_mozilla_cycle_collect,372 12:38:50 INFO - PROCESS | 8439 | __end_cc_report 12:38:50 INFO - PROCESS | 8439 | __startTimestamp1460749130854__endTimestamp 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | ------- Summary: start ------- 12:38:50 INFO - PROCESS | 8439 | Number of tests: 6 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#0] dojo.html Cycles:165 Average:4654.33 Median:4799.81 stddev:481.45 (10.0%) stddev-sans-first:454.96 12:38:50 INFO - PROCESS | 8439 | Values: 2592.8 2672.5 2688.7 2706.9 2710.1 4660.2 4694.5 4705.8 4722.2 4748.4 4629.1 4656.4 4717.7 4728.6 4764.9 4283.0 4341.4 4345.3 4347.6 4401.2 4389.0 4423.4 4429.5 4434.3 4490.4 4211.2 4322.7 4399.1 4412.6 4416.5 4285.9 4294.7 4300.9 4331.0 4331.8 4185.4 4264.2 4275.6 4276.3 4317.8 4575.1 4624.7 4642.1 4681.9 4695.7 5063.0 5074.6 5091.9 5103.4 5107.3 4863.6 4942.5 5074.2 5092.4 5147.8 4721.1 4723.9 4732.1 4740.1 4795.8 5128.7 5179.6 5186.8 5208.7 5215.0 4768.7 4910.8 4988.1 4999.7 5044.9 4933.8 5022.9 5074.8 5106.6 5124.6 4980.0 4982.4 4985.3 5006.2 5058.0 4824.7 4926.4 4946.1 4964.8 5000.4 4217.9 4254.8 4269.5 4313.7 4320.4 3683.5 3704.7 3719.6 3760.7 3772.2 4248.8 4329.8 4336.8 4356.4 4400.6 5047.8 5084.3 5096.6 5096.8 5149.1 4367.5 4373.0 4382.5 4398.2 4411.3 4469.3 4495.0 4562.6 4582.5 4612.6 4809.0 4810.3 4818.3 4819.3 4828.7 5088.2 5099.5 5114.9 5116.5 5123.2 4586.1 4716.2 4799.8 4807.1 4812.2 4886.9 4905.3 4936.1 4941.0 4985.2 4905.2 5035.2 5060.4 5076.2 5123.0 4745.2 4825.3 4854.9 4918.1 4956.1 4806.5 4841.7 4851.6 4870.5 4969.3 4644.2 4820.2 4832.9 4840.7 4857.8 4798.9 4833.7 4840.8 4844.4 4849.1 4680.9 4801.3 4879.7 4882.6 4924.1 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#1] ext.html Cycles:180 Average:43728.34 Median:33956.08 stddev:80967.48 (238.4%) stddev-sans-first:81129.69 12:38:50 INFO - PROCESS | 8439 | Values: 542.3 596.4 614.0 615.2 649.4 31860.2 33114.2 33128.0 33165.7 33173.5 33944.7 34147.7 34353.5 34438.3 34544.3 7456.9 7647.5 7648.1 7648.9 7659.0 7478.4 7676.5 7729.8 7735.0 7780.4 7727.3 7794.6 7818.2 7828.6 7836.0 7738.9 7788.8 7804.9 7806.7 7809.9 7707.6 7816.7 7817.5 7826.6 7827.3 28697.4 34859.3 34903.5 35315.8 35516.5 2991.5 3109.9 3186.5 3204.3 3272.2 26808.6 27558.7 27835.3 28256.6 28445.4 3367.1 3390.7 3467.6 3583.2 3608.0 184908.0 188007.0 188820.0 188932.1 189387.0 33967.5 35058.6 35103.0 56287.4 57644.4 33411.8 33429.3 33587.7 33611.0 33784.3 12333.5 12499.8 12504.9 12533.5 12543.0 10985.6 11071.3 11071.5 11078.9 11092.1 8267.2 8385.1 8455.3 8460.5 8462.5 3302.3 3319.7 3341.2 3350.7 3401.0 948.3 982.7 1004.5 1007.8 1029.2 28518.4 28631.9 28754.3 28809.7 28986.6 973.8 1026.7 1087.6 1135.2 1151.4 14857.9 15375.7 15431.8 15514.7 15615.8 354215.0 363599.0 366961.0 368401.0 369485.0 49215.3 50001.0 50121.2 50204.7 50324.7 1172.9 1226.4 1275.1 1278.1 1285.1 26482.9 27766.4 28003.3 28291.2 28330.6 42575.0 42931.8 43158.4 43160.1 43193.4 334749.0 336191.0 337091.0 337196.0 337797.0 25747.9 26043.7 26148.0 26270.7 26771.9 41279.2 42028.6 42539.5 42589.0 42607.1 35668.6 36007.6 36450.0 36574.3 36959.4 34624.1 35124.6 35139.5 35627.1 35783.8 31963.6 34566.1 34631.0 35814.0 36090.8 28428.9 30504.2 31064.8 31118.4 31165.5 24195.9 24291.5 24773.9 24836.4 25069.9 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#2] jquery.html Cycles:180 Average:23796.30 Median:225980.69 stddev:65821.31 (29.1%) stddev-sans-first:65982.48 12:38:50 INFO - PROCESS | 8439 | Values: 382.1 382.4 392.4 392.6 397.5 13178.3 15798.2 16052.9 17687.7 17731.3 16336.3 16933.8 16979.5 17050.3 17453.2 4943.7 5073.0 5214.3 5225.0 5229.1 5065.6 5114.4 5131.7 5189.3 5189.6 4901.6 5064.2 5070.2 5099.5 5214.6 5173.8 5194.5 5196.7 5204.5 5227.5 4497.5 4600.7 4669.9 4673.8 4692.5 20045.7 20330.3 20370.8 20523.3 20757.0 1875.8 2008.1 2030.6 2244.4 2377.9 13188.7 13331.9 13387.8 13405.7 13721.2 1786.9 1792.9 1851.8 1866.6 1868.6 67565.7 68080.0 68336.0 68508.7 68608.0 8521.5 8953.8 9569.1 9679.4 9738.1 11381.9 11862.3 12858.8 12864.0 12881.9 6651.8 6804.9 7012.5 7093.4 7281.3 6633.6 6645.6 6657.7 6770.0 6773.9 5770.9 5909.8 5974.4 6011.3 6080.8 1701.2 1739.4 1776.2 1807.0 1825.2 799.5 819.9 827.9 863.8 869.3 14528.3 14925.8 15002.7 15088.2 15184.2 809.3 818.3 830.8 833.3 841.2 6357.4 8323.6 8472.3 8667.7 8672.5 392119.0 393012.0 402823.0 404403.0 410476.0 43696.0 69671.3 71411.6 72704.0 81362.0 967.1 969.8 984.8 996.4 998.8 13275.1 13310.7 13678.7 13692.3 13742.8 30875.2 31571.4 31833.5 33506.5 33876.8 40014.4 40340.2 40677.0 41485.4 45328.8 5143.5 6899.1 7482.5 7639.0 7772.7 10167.6 11245.8 11252.7 11489.1 12036.1 10161.2 10233.0 10311.3 10430.4 10513.5 10447.3 10469.0 10493.6 10567.7 10775.8 10063.5 10321.3 10413.5 10684.2 11007.3 7797.8 7879.6 7896.9 7906.4 7908.9 8077.0 9651.9 10788.5 10899.2 11064.6 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#3] mootools.html Cycles:180 Average:5224.58 Median:5698.23 stddev:2847.33 (50.0%) stddev-sans-first:2841.11 12:38:50 INFO - PROCESS | 8439 | Values: 1439.9 1470.9 1595.6 1764.7 1814.2 6908.2 7431.4 7667.7 7767.7 7802.0 7627.2 7664.3 7665.0 7705.8 7717.0 2259.6 2290.2 2295.8 2296.4 2306.5 2243.8 2252.8 2273.7 2276.6 2278.1 2247.5 2249.7 2250.2 2266.7 2279.1 2170.3 2185.5 2186.9 2188.0 2188.0 2224.5 2269.9 2276.4 2282.9 2284.5 7936.9 7948.1 7951.4 8011.4 8023.8 4734.9 4890.6 4917.7 4926.4 4946.9 2845.4 2850.2 2853.5 2857.0 2884.4 924.8 946.8 965.5 976.4 978.1 10696.6 10730.5 10736.5 10756.0 10779.8 4313.9 4340.5 4472.0 4526.6 4535.1 9159.0 9182.1 9194.3 9209.8 9234.3 4629.7 4659.9 4682.4 4684.7 4710.3 3791.2 4209.2 4219.1 4275.2 4390.0 3646.7 3663.9 3689.1 3722.8 3772.2 1244.5 1256.7 1263.0 1269.4 1288.7 752.5 781.4 867.8 909.7 920.6 5380.8 5571.6 5688.9 5779.7 5828.9 876.0 972.4 992.3 1011.9 1020.4 3633.3 3807.4 3872.1 3908.5 3940.2 9444.9 9738.7 9824.6 9846.9 9883.0 9612.2 9637.9 9640.2 9749.4 9791.0 6903.1 7394.8 7505.3 7547.7 7552.2 5697.1 5699.4 5737.2 5757.1 5763.7 8942.5 8965.1 9040.0 9047.1 9142.1 8323.9 8770.2 8800.5 8805.7 8806.8 5993.3 6650.0 6668.5 6799.8 6855.1 7203.3 7217.4 7300.2 7308.4 7330.2 6484.6 6721.1 6751.0 6766.3 6804.9 6610.4 6613.3 6763.3 6827.3 6861.9 6449.4 6484.1 6499.9 6561.1 6568.1 4805.3 4890.5 4909.1 4927.6 4940.4 4806.1 4807.8 4842.0 4897.1 4947.6 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#4] prototype.html Cycles:180 Average:4642.33 Median:5329.69 stddev:1370.90 (25.7%) stddev-sans-first:1335.67 12:38:50 INFO - PROCESS | 8439 | Values: 312.6 315.7 321.8 322.3 324.6 5325.7 5327.7 5374.0 5382.7 5384.4 5289.9 5301.8 5313.7 5331.7 5336.4 3886.5 3999.4 4092.8 4144.5 4177.1 4142.2 4154.6 4161.9 4162.1 4180.2 4113.9 4130.0 4133.9 4137.8 4146.7 4031.8 4084.8 4092.4 4107.8 4110.3 3600.8 3601.3 3601.6 3617.2 3620.7 5082.0 5105.4 5118.8 5119.3 5135.7 4566.4 4753.8 4764.4 4765.0 4765.7 5587.6 5598.4 5599.8 5605.5 5632.3 3934.8 3956.5 3959.3 3968.4 3968.5 5556.9 5913.1 5924.8 5935.3 5942.8 3945.8 3977.7 3986.7 3991.5 4001.6 4051.3 4054.3 4058.2 4065.1 4078.6 4603.8 4671.4 4673.6 4683.7 4686.6 5651.1 5659.6 5663.3 5667.0 5670.5 1393.8 1408.1 1408.2 1409.9 1413.8 875.2 902.6 938.7 959.7 961.0 4809.6 4822.0 4827.9 4834.6 4859.4 5719.2 5746.7 5748.2 5761.1 5766.5 4655.5 4783.2 4817.3 4820.9 4906.0 3116.4 3125.5 3145.4 3146.0 3149.9 5468.7 5486.1 5489.6 5495.7 5498.6 5852.8 5914.9 5948.7 5981.6 5987.1 5422.9 5453.7 5458.6 5483.5 5513.6 5639.2 5836.4 5839.4 5847.0 5859.3 5730.3 5736.9 5739.2 5753.9 5758.8 5470.6 5473.7 5476.3 5496.3 5516.4 3928.4 3939.9 3967.4 4007.2 4020.8 5801.5 5818.4 5823.5 5851.4 5869.9 5597.3 5613.5 5644.7 5657.3 5667.9 5487.1 5583.2 5619.9 5636.6 5637.5 5247.0 5521.4 5526.2 5548.4 5552.4 5439.8 5662.7 5667.9 5676.3 5688.4 5524.5 5543.5 5550.4 5555.7 5579.6 12:38:50 INFO - PROCESS | 8439 | 12:38:50 INFO - PROCESS | 8439 | [#5] yui.html Cycles:180 Average:13157.45 Median:48245.26 stddev:15606.23 (32.3%) stddev-sans-first:15622.03 12:38:50 INFO - PROCESS | 8439 | Values: 713.6 736.6 769.3 781.4 786.6 11398.8 11603.3 11628.4 11664.9 11669.9 11236.7 11309.9 11963.5 12583.0 12625.3 803.2 805.7 807.8 808.4 810.7 641.6 794.1 800.1 801.7 808.0 841.8 844.3 846.3 850.1 850.4 830.6 838.1 839.8 840.7 841.5 610.4 611.8 613.1 613.2 613.6 11609.7 11634.0 11679.1 12126.2 12133.9 12917.4 13097.1 13124.8 13149.3 13473.8 10135.5 10241.4 10284.8 10291.3 10404.1 3333.7 3367.2 3389.3 3392.2 3472.7 47807.8 48110.8 48236.5 48254.0 48261.8 10289.7 10387.0 10439.3 10544.3 10645.0 18070.5 18211.4 18416.1 18469.7 18524.4 7283.6 7356.6 7416.6 7431.4 7463.1 3893.3 3952.9 3996.9 4014.3 4027.4 2869.6 2947.3 2949.3 2950.2 2966.6 544.9 560.3 560.6 561.9 595.7 580.9 594.1 610.4 625.4 647.2 7959.8 8037.3 8042.2 8146.4 8575.7 502.0 537.4 583.2 635.7 650.4 3976.6 4006.0 4048.8 4133.5 4234.2 57428.0 57497.7 58120.7 58340.0 58392.4 49120.0 49852.3 49863.3 50517.5 50954.0 45925.5 45983.8 46072.5 46174.8 46752.5 7659.3 7728.7 7788.6 7891.0 7946.2 29206.9 30077.0 30433.2 30778.5 30902.2 37406.0 40999.0 41487.0 41592.4 42189.0 9771.0 9897.7 9903.0 10098.5 10438.3 10149.4 10187.6 10467.2 10539.4 10608.0 10021.2 10173.6 10214.3 10218.8 10265.4 10251.9 10278.3 10408.5 10525.4 10606.7 9775.4 9862.9 9950.7 9964.6 10290.6 8378.5 8402.8 8697.2 8732.2 8886.7 8848.3 8909.5 9024.7 9036.1 9243.4 12:38:50 INFO - PROCESS | 8439 | -------- Summary: end -------- 12:38:50 INFO - PROCESS | 8439 | 12:38:51 INFO - TEST-INFO | 8439: exit 0 12:38:51 INFO - TEST-OK | dromaeo_css | took 1115297ms 12:38:51 INFO - TEST-START | kraken 12:38:51 INFO - operating with platform_type : linux_ 12:38:51 INFO - Initialising browser for kraken test... 12:38:51 INFO - TEST-INFO | started process 8675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx18b4/profile http://localhost:55764/getInfo.html) 12:38:55 INFO - PROCESS | 8675 | 12:38:55 INFO - PROCESS | 8675 | (process:8742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:38:55 INFO - PROCESS | 8675 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:38:56 INFO - PROCESS | 8675 | __metrics Screen width/height:1600/1200 12:38:56 INFO - PROCESS | 8675 | colorDepth:24 12:38:56 INFO - PROCESS | 8675 | Browser inner width/height: 1024/697 12:38:56 INFO - PROCESS | 8675 | __metrics 12:38:56 ERROR - PROCESS | 8675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:38:57 INFO - TEST-INFO | 8675: exit 0 12:38:57 INFO - Browser initialized. 12:38:57 INFO - Running cycle 1/1 for kraken test... 12:38:57 INFO - TEST-INFO | started process 8793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx18b4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:59 INFO - PROCESS | 8793 | 12:38:59 INFO - PROCESS | 8793 | (process:8851): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:39:09 INFO - PROCESS | 8793 | RSS: Main: 164274176 12:39:09 INFO - PROCESS | 8793 | 12:39:12 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55764/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:13 INFO - PROCESS | 8793 | RSS: Main: 168611840 12:39:13 INFO - PROCESS | 8793 | 12:39:15 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55764/tests/kraken/driver.html?testName=audio-dft) 12:39:16 INFO - PROCESS | 8793 | RSS: Main: 172003328 12:39:16 INFO - PROCESS | 8793 | 12:39:19 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55764/tests/kraken/driver.html?testName=audio-fft) 12:39:20 INFO - PROCESS | 8793 | RSS: Main: 164110336 12:39:20 INFO - PROCESS | 8793 | 12:39:22 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55764/tests/kraken/driver.html?testName=audio-oscillator) 12:39:22 INFO - PROCESS | 8793 | RSS: Main: 163725312 12:39:22 INFO - PROCESS | 8793 | 12:39:25 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:25 INFO - PROCESS | 8793 | RSS: Main: 164990976 12:39:25 INFO - PROCESS | 8793 | 12:39:28 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55764/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:29 INFO - PROCESS | 8793 | RSS: Main: 164503552 12:39:29 INFO - PROCESS | 8793 | 12:39:33 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55764/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:33 INFO - PROCESS | 8793 | RSS: Main: 164089856 12:39:33 INFO - PROCESS | 8793 | 12:39:36 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55764/tests/kraken/driver.html?testName=json-parse-financial) 12:39:37 INFO - PROCESS | 8793 | RSS: Main: 165064704 12:39:37 INFO - PROCESS | 8793 | 12:39:38 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:39 INFO - PROCESS | 8793 | RSS: Main: 165351424 12:39:39 INFO - PROCESS | 8793 | 12:39:41 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:42 INFO - PROCESS | 8793 | RSS: Main: 165978112 12:39:42 INFO - PROCESS | 8793 | 12:39:44 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:44 INFO - PROCESS | 8793 | RSS: Main: 165605376 12:39:44 INFO - PROCESS | 8793 | 12:39:47 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:48 INFO - PROCESS | 8793 | RSS: Main: 166027264 12:39:48 INFO - PROCESS | 8793 | 12:39:51 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:51 INFO - PROCESS | 8793 | RSS: Main: 165531648 12:39:51 INFO - PROCESS | 8793 | 12:39:53 INFO - PROCESS | 8793 | Cycle 1(1): loaded http://localhost:55764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55764/tests/kraken/driver.html?testName=ai-astar) 12:39:54 INFO - PROCESS | 8793 | RSS: Main: 166948864 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | __start_tp_report 12:39:54 INFO - PROCESS | 8793 | _x_x_mozilla_page_load 12:39:54 INFO - PROCESS | 8793 | _x_x_mozilla_page_load_details 12:39:54 INFO - PROCESS | 8793 | |i|pagename|runs| 12:39:54 INFO - PROCESS | 8793 | |0;ai-astar;116;108;114;112;115;124;114;116;115;112 12:39:54 INFO - PROCESS | 8793 | |1;audio-beat-detection;163;136;161;172;136;157;162;133;190;133 12:39:54 INFO - PROCESS | 8793 | |2;audio-dft;163;162;169;165;167;163;164;164;164;163 12:39:54 INFO - PROCESS | 8793 | |3;audio-fft;74;75;75;161;77;75;75;76;159;74 12:39:54 INFO - PROCESS | 8793 | |4;audio-oscillator;96;95;145;94;95;92;137;95;94;141 12:39:54 INFO - PROCESS | 8793 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;118;117;118 12:39:54 INFO - PROCESS | 8793 | |6;imaging-darkroom;147;149;147;149;147;147;148;147;148;147 12:39:54 INFO - PROCESS | 8793 | |7;imaging-desaturate;96;96;96;95;96;95;95;96;95;95 12:39:54 INFO - PROCESS | 8793 | |8;json-parse-financial;65;66;66;69;66;66;69;96;63;63 12:39:54 INFO - PROCESS | 8793 | |9;json-stringify-tinderbox;65;65;66;65;64;64;65;66;66;65 12:39:54 INFO - PROCESS | 8793 | |10;stanford-crypto-aes;80;82;80;81;81;79;80;89;80;80 12:39:54 INFO - PROCESS | 8793 | |11;stanford-crypto-ccm;135;133;132;140;138;137;131;136;164;139 12:39:54 INFO - PROCESS | 8793 | |12;stanford-crypto-pbkdf2;172;173;177;176;177;178;170;177;174;170 12:39:54 INFO - PROCESS | 8793 | |13;stanford-crypto-sha256-iterative;72;73;74;73;74;73;72;69;73;72 12:39:54 INFO - PROCESS | 8793 | __end_tp_report 12:39:54 INFO - PROCESS | 8793 | __start_cc_report 12:39:54 INFO - PROCESS | 8793 | _x_x_mozilla_cycle_collect,899 12:39:54 INFO - PROCESS | 8793 | __end_cc_report 12:39:54 INFO - PROCESS | 8793 | __startTimestamp1460749194004__endTimestamp 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | ------- Summary: start ------- 12:39:54 INFO - PROCESS | 8793 | Number of tests: 14 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:4.09 (3.6%) stddev-sans-first:4.30 12:39:54 INFO - PROCESS | 8793 | Values: 116.0 108.0 114.0 112.0 115.0 124.0 114.0 116.0 115.0 112.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:161.50 stddev:19.30 (11.9%) stddev-sans-first:20.21 12:39:54 INFO - PROCESS | 8793 | Values: 163.0 136.0 161.0 172.0 136.0 157.0 162.0 133.0 190.0 133.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.19 12:39:54 INFO - PROCESS | 8793 | Values: 163.0 162.0 169.0 165.0 167.0 163.0 164.0 164.0 164.0 163.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.00 stddev:35.80 (47.7%) stddev-sans-first:37.37 12:39:54 INFO - PROCESS | 8793 | Values: 74.0 75.0 75.0 161.0 77.0 75.0 75.0 76.0 159.0 74.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.50 stddev:22.60 (23.9%) stddev-sans-first:23.52 12:39:54 INFO - PROCESS | 8793 | Values: 96.0 95.0 145.0 94.0 95.0 92.0 137.0 95.0 94.0 141.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:39:54 INFO - PROCESS | 8793 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 12:39:54 INFO - PROCESS | 8793 | Values: 147.0 149.0 147.0 149.0 147.0 147.0 148.0 147.0 148.0 147.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:39:54 INFO - PROCESS | 8793 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:66.00 stddev:9.73 (14.7%) stddev-sans-first:10.22 12:39:54 INFO - PROCESS | 8793 | Values: 65.0 66.0 66.0 69.0 66.0 66.0 69.0 96.0 63.0 63.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 12:39:54 INFO - PROCESS | 8793 | Values: 65.0 65.0 66.0 65.0 64.0 64.0 65.0 66.0 66.0 65.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:2.86 (3.6%) stddev-sans-first:3.00 12:39:54 INFO - PROCESS | 8793 | Values: 80.0 82.0 80.0 81.0 81.0 79.0 80.0 89.0 80.0 80.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.50 stddev:9.44 (6.9%) stddev-sans-first:9.93 12:39:54 INFO - PROCESS | 8793 | Values: 135.0 133.0 132.0 140.0 138.0 137.0 131.0 136.0 164.0 139.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:176.50 stddev:3.03 (1.7%) stddev-sans-first:3.08 12:39:54 INFO - PROCESS | 8793 | Values: 172.0 173.0 177.0 176.0 177.0 178.0 170.0 177.0 174.0 170.0 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - PROCESS | 8793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 12:39:54 INFO - PROCESS | 8793 | Values: 72.0 73.0 74.0 73.0 74.0 73.0 72.0 69.0 73.0 72.0 12:39:54 INFO - PROCESS | 8793 | -------- Summary: end -------- 12:39:54 INFO - PROCESS | 8793 | 12:39:54 INFO - TEST-INFO | 8793: exit 0 12:39:55 INFO - TEST-OK | kraken | took 63428ms 12:39:55 INFO - SUITE-END | took 1178s 12:39:55 INFO - Completed test suite (00:19:38) 12:39:55 INFO - javascript benchmark 12:39:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.7925765938726, 2672.4788666210097, 2688.7311268873104, 2706.9458610827774, 2710.146303914267, 4660.231061874791, 4694.507076756939, 4705.835295764649, 4722.220833562458, 4748.406449193851, 4629.074185162964, 4656.371389862367, 4717.669763116583, 4728.621710263179, 4764.928526072112, 4283.036316828712, 4341.435613370273, 4345.348197770344, 4347.630451411634, 4401.163778882018, 4388.956110438902, 4423.358613001113, 4429.5348988356245, 4434.312681534368, 4490.438695163105, 4211.241976444254, 4322.675799315064, 4399.12017596482, 4412.646988240933, 4416.53626369233, 4285.914281714348, 4294.7423154610515, 4300.935485967713, 4330.978345108254, 4331.805068771912, 4185.351270553038, 4264.23243816113, 4275.636570891478, 4276.294411422112, 4317.848875289381, 4575.084983003379, 4624.745638989854, 4642.117997580483, 4681.882952926204, 4695.694779839299, 5063.0380227756605, 5074.568661663763, 5091.9236211456855, 5103.362079740033, 5107.3360463139925, 4863.586595139417, 4942.5304596063315, 5074.188129899198, 5092.439831618519, 5147.794088236466, 4721.055788842245, 4723.937114149323, 4732.1009008289, 4740.1230772307235, 4795.832145874878, 5128.743562821844, 5179.559737422362, 5186.766595503136, 5208.661437006583, 5215.0, 4768.737719425396, 4910.754462276872, 4988.127077761377, 4999.65002449825, 5044.899102017939, 4933.753312334369, 5022.89954200914, 5074.847754567369, 5106.565941894981, 5124.56441202502, 4980.028894365564, 4982.377202849644, 4985.326980857538, 5006.249062640633, 5058.013687331008, 4824.734639594786, 4926.359573255454, 4946.08497427977, 4964.801407943642, 5000.424951130666, 4217.8523751668545, 4254.829806807755, 4269.466316710411, 4313.741175529478, 4320.4383430153875, 3683.4552379249985, 3704.7221458390727, 3719.6094410087094, 3760.6615404613717, 3772.1889793694486, 4248.830046798155, 4329.826806927751, 4336.783160842008, 4356.390105385249, 4400.581944715247, 5047.848564543069, 5084.339035925306, 5096.592272618182, 5096.847094587169, 5149.098907691214, 4367.519572846984, 4373.037931655031, 4382.499962547046, 4398.164348773723, 4411.316245981878, 4469.307257375047, 4495.033567782877, 4562.589366956923, 4582.450105987303, 4612.60792832613, 4809.038192361541, 4810.254410566367, 4818.277258411266, 4819.349387832738, 4828.7102773833685, 5088.236764485208, 5099.482690012026, 5114.8977020460125, 5116.539511443988, 5123.154679477844, 4586.1057093866375, 4716.221823399238, 4799.808007679654, 4807.134715751198, 4812.181929071996, 4886.926696099633, 4905.337779399878, 4936.136176169228, 4940.950590494049, 4985.177445721415, 4905.166121759381, 5035.244713293036, 5060.367454068241, 5076.238564215398, 5123.026624941249, 4745.217039188496, 4825.30033145199, 4854.854354369375, 4918.139325617931, 4956.083124621957, 4806.49531799156, 4841.709497430165, 4851.611871050378, 4870.537298956593, 4969.279454479008, 4644.23370143936, 4820.204666230173, 4832.855014349575, 4840.661153719206, 4857.757112144449, 4798.856034318976, 4833.709977401367, 4840.830570930141, 4844.370231869834, 4849.07867505187, 4680.929786053144, 4801.255805350176, 4879.658423910292, 4882.6084565898545, 4924.113659541317], "value": 4624.350228902163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.3383472163958, 596.4482853360641, 613.9631622102672, 615.2371059885743, 649.4252586460981, 31860.20349491264, 33114.17214569637, 33128.0, 33165.66834331659, 33173.50239746406, 33944.66055339446, 34147.65852341476, 34353.48469772955, 34438.31123377537, 34544.30911381771, 7456.88814667779, 7647.50291231071, 7648.0822301323915, 7648.923510764905, 7658.9617051914665, 7478.401727861785, 7676.46264761467, 7729.8067548311465, 7734.988902885262, 7780.416468764837, 7727.304542591166, 7794.571298578604, 7818.218178182193, 7828.647710852997, 7836.0, 7738.883916741253, 7788.844223115534, 7804.921950780476, 7806.726764563241, 7809.921900780976, 7707.614619269014, 7816.72641457552, 7817.530948143073, 7826.647800848918, 7827.295543401065, 28697.426051479062, 34859.30281394358, 34903.4764478533, 35315.82342088299, 35516.46725299123, 2991.5213565829363, 3109.9378012439624, 3186.5256623257583, 3204.3431096625136, 3272.2473831018997, 26808.59787103195, 27558.724412755815, 27835.304117397023, 28256.576151357745, 28445.431091378057, 3367.1245476176127, 3390.69483746464, 3467.6185619581825, 3583.2475180211927, 3608.0, 184908.0, 188007.0, 188820.0, 188932.0553397238, 189387.0, 33967.4904876427, 35058.59765609347, 35103.0, 56287.43712562904, 57644.42355576474, 33411.83294083563, 33429.3314133716, 33587.66412335894, 33611.0, 33784.32431351408, 12333.50665973369, 12499.750004999849, 12504.937475312565, 12533.498660053678, 12543.0, 10985.61550345734, 11071.335719856834, 11071.501782419811, 11078.947499987487, 11092.057175140204, 8267.173282671685, 8385.077641459435, 8455.323574114056, 8460.534670593177, 8462.534560599102, 3302.2734998300816, 3319.668033196661, 3341.2482191506715, 3350.69843714062, 3401.0, 948.2887834124407, 982.6511588386163, 1004.4726518577659, 1007.8387458006683, 1029.1663752360612, 28518.429631407256, 28631.856840715664, 28754.281142971595, 28809.71190288112, 28986.565201521993, 973.8052389522123, 1026.7381817636456, 1087.6302057300556, 1135.2280449294394, 1151.3955173533961, 14857.925710371379, 15375.692486150214, 15431.768523472158, 15514.689706205812, 15615.843841561666, 354215.0, 363599.0, 366961.0, 368401.0, 369485.0, 49215.26177107346, 50001.0, 50121.24818127731, 50204.748976255614, 50324.72889262186, 1172.9061675065975, 1226.3929354969348, 1275.0564582209283, 1278.0733967873218, 1285.0747461827468, 26482.86758566195, 27766.44467110687, 28003.299917502227, 28291.151265462067, 28330.575041374806, 42575.0, 42931.7853410731, 43158.35262471002, 43160.13679726451, 43193.3520997179, 334749.0, 336191.0, 337091.0, 337196.0, 337797.0, 25747.871260643577, 26043.739562604133, 26148.0, 26270.73729262683, 26771.86614066917, 41279.174416512105, 42028.57971420247, 42539.51111711075, 42589.0, 42607.147857042066, 35668.643313566536, 36007.63992360043, 36450.0, 36574.268514630094, 36959.44560831536, 34624.134396640286, 35124.648753512134, 35139.47290790589, 35627.10932226715, 35783.82108089443, 31963.611671426166, 34566.13584660403, 34631.0, 35814.0, 36090.819545903156, 28428.85785571059, 30504.237394065327, 31064.844675776476, 31118.377632446773, 31165.532517012718, 24195.879020604785, 24291.514169716862, 24773.876130619232, 24836.37909052288, 25069.87465062663], "value": 16176.969948833024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.1001541370073, 382.37481717392075, 392.3604524624861, 392.621120618603, 397.46937837986286, 13178.341082945863, 15798.210089495522, 16052.919735401307, 17687.734683979736, 17731.290748370066, 16336.264868080934, 16933.83066169338, 16979.49061528153, 17050.317987280494, 17453.214605342757, 4943.6539442239055, 5072.9746351268195, 5214.348206474191, 5225.0, 5229.08491014071, 5065.594752419816, 5114.411842638088, 5131.666441681297, 5189.273501709764, 5189.558887494568, 4901.558859702626, 5064.189729643258, 5070.163423035213, 5099.541041306282, 5214.556762675177, 5173.793048278064, 5194.532492075694, 5196.68819870809, 5204.531592156705, 5227.4511176326505, 4497.460304763416, 4600.700954437951, 4669.929951050737, 4673.836415725434, 4692.507286734912, 20045.699314510293, 20330.288439904532, 20370.796292037037, 20523.281685140948, 20757.0, 1875.831175194239, 2008.1365013044385, 2030.614183305182, 2244.4276709438986, 2377.941815891929, 13188.736225275537, 13331.933340333333, 13387.799183012263, 13405.66485837852, 13721.245331506763, 1786.8749187556875, 1792.865535084874, 1851.8333349998566, 1866.5986812835306, 1868.5982513759607, 67565.66217168931, 68080.0, 68336.0, 68508.6574567129, 68608.0, 8521.488710677379, 8953.820923581492, 9569.138777510057, 9679.419234845931, 9738.123568878835, 11381.943090284496, 11862.347570883685, 12858.807117893239, 12864.0, 12881.935590321988, 6651.833704157338, 6804.9319506804295, 7012.474064445187, 7093.397061249749, 7281.308275713799, 6633.568818026813, 6645.568038077607, 6657.667116644148, 6769.966150169218, 6773.8645227095185, 5770.88458230833, 5909.8227053188475, 5974.386915532782, 6011.3086994995265, 6080.817575472743, 1701.157926826229, 1739.4259894234872, 1776.1740790532465, 1807.0242069282704, 1825.2242796811302, 799.4683535448861, 819.8524265632124, 827.8758186271987, 863.7883718488885, 869.3306154261184, 14528.273586320642, 14925.776113358308, 15002.69994600102, 15088.24558772057, 15184.164870932205, 809.287826712501, 818.3289702443939, 830.7507747675673, 833.2875391540267, 841.1798496465897, 6357.427831495188, 8323.583820808935, 8472.279856212292, 8667.739967800977, 8672.523011234316, 392119.0, 393012.0, 402823.0, 404403.0, 410476.0, 43696.0, 69671.3032869675, 71411.64294178496, 72704.0, 81362.0, 967.1295833749682, 969.762408209993, 984.7931934293736, 996.3822430093388, 998.7902540466438, 13275.137116087424, 13310.733785324433, 13678.726425471235, 13692.31538423055, 13742.793858092336, 30875.228119297197, 31571.36857262888, 31833.522497163023, 33506.497402538494, 33876.83061584775, 40014.39978400268, 40340.1931961365, 40677.0, 41485.37771933363, 45328.77335613301, 5143.459936706592, 6899.103116594811, 7482.476226664081, 7638.961805190938, 7772.727954521564, 10167.644132455329, 11245.831312530483, 11252.718682033015, 11489.138314626269, 12036.097292702907, 10161.187105031728, 10233.0, 10311.329763565343, 10430.426326552113, 10513.476765576359, 10447.320924139907, 10469.0, 10493.632722854663, 10567.682969510619, 10775.838362424412, 10063.547140378554, 10321.277510574188, 10413.479326033517, 10684.198685098803, 11007.284526505751, 7797.805054873674, 7879.645415956181, 7896.921030789618, 7906.446548741533, 7908.881366779618, 8076.959615201887, 9651.9034809651, 10788.514516846604, 10899.237053406185, 11064.612738554433], "value": 8050.356467908478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.9352029158688, 1470.94827198553, 1595.64895722941, 1764.7352897065446, 1814.1745505794865, 6908.20555636102, 7431.405487560995, 7667.654955527, 7767.6892924282965, 7801.960990195048, 7627.199144089874, 7664.310212080912, 7665.0, 7705.807354816133, 7716.996790417238, 2259.559385919742, 2290.1640901071155, 2295.7819007194375, 2296.3570200343847, 2306.4925716342377, 2243.842930994831, 2252.774722527742, 2273.7385200701965, 2276.590213761522, 2278.0773786616446, 2247.4718441166315, 2249.6737972993906, 2250.1561914282142, 2266.660000999847, 2279.0883646541433, 2170.338046895696, 2185.4754858833926, 2186.868787872733, 2187.9671804922937, 2187.9781202188015, 2224.5217278285245, 2269.863808171515, 2276.430892276931, 2282.9086836526685, 2284.4859906521065, 7936.920630793676, 7948.125706172316, 7951.443398962075, 8011.439199256054, 8023.799405014863, 4734.881627959294, 4890.584300334476, 4917.680350777188, 4926.433460152092, 4946.9010619787405, 2845.445138198052, 2850.230437781808, 2853.5149024665857, 2857.00004998251, 2884.379858330448, 924.8057907839362, 946.8248374050754, 965.5365424596163, 976.4092723902008, 978.1099199728284, 10696.572137114506, 10730.517126729315, 10736.463176841127, 10756.0, 10779.78440431187, 4313.913721725611, 4340.500842403101, 4471.977640111843, 4526.569975852289, 4535.138323718483, 9159.0, 9182.127697868691, 9194.264458843276, 9209.769755756026, 9234.261259099256, 4629.699069560468, 4659.930101048487, 4682.41469816273, 4684.672072954929, 4710.317004034396, 3791.1659434924272, 4209.2423363794815, 4219.0507135894795, 4275.230458517434, 4389.956100439019, 3646.7082633389264, 3663.87176448823, 3689.1330537323706, 3722.813859307024, 3772.2078363543415, 1244.502199120341, 1256.723520825417, 1262.9873701263054, 1269.435101379877, 1288.7486940046788, 752.4920678541962, 781.3827076609415, 867.8134201146657, 909.6543313540813, 920.6179435534178, 5380.757865896044, 5571.609987300931, 5688.914666280009, 5779.711014449261, 5828.88342233153, 875.9737207883774, 972.4457059476172, 992.270681049428, 1011.8735158105237, 1020.3826684855704, 3633.291508155884, 3807.4098514730263, 3872.0513474198438, 3908.5309762828074, 3940.2119576084897, 9444.90555094454, 9738.659146929966, 9824.607015719434, 9846.901530984598, 9882.950585247172, 9612.18296444796, 9637.855432168522, 9640.228781697448, 9749.415035097916, 9791.020897910294, 6903.137107861618, 7394.815129621803, 7505.286997735207, 7547.73582924595, 7552.169261381244, 5697.088465845445, 5699.373068962494, 5737.196792448977, 5757.050086735641, 5763.7118144093465, 8942.46345219289, 8965.103489650983, 9040.0, 9047.095290470901, 9142.131497507726, 8323.916760832557, 8770.166834150745, 8800.471971681463, 8805.691800787197, 8806.823863522823, 5993.280806303272, 6650.0, 6668.466522678271, 6799.796006119825, 6855.07456493367, 7203.279672032755, 7217.386522145676, 7300.196978332486, 7308.415326773739, 7330.193678695233, 6484.578502397329, 6721.092652491851, 6751.0, 6766.255711871789, 6804.863902722017, 6610.405063544112, 6613.305602911817, 6763.323667633197, 6827.283135270725, 6861.897071543831, 6449.419552240321, 6484.092227088306, 6499.935000649933, 6561.081448597296, 6568.146141001639, 4805.327254184487, 4890.510948905081, 4909.091818013536, 4927.581155601671, 4940.431850337257, 4806.134895718804, 4807.807687692593, 4842.031593681349, 4897.069556784199, 4947.554720075211], "value": 4254.568229461728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6014331727048, 315.6622414017002, 321.8246055899535, 322.2652352635991, 324.62505805794285, 5325.733713314334, 5327.653702509339, 5374.032674118657, 5382.730863456822, 5384.434634363394, 5289.947100528993, 5301.814436494724, 5313.654612450188, 5331.733413329328, 5336.359636843575, 3886.514185726777, 3999.4200840878057, 4092.774897380643, 4144.502659680843, 4177.122804211104, 4142.212979533879, 4154.626083652471, 4161.9375709364385, 4162.125953549758, 4180.184863951531, 4113.938290925638, 4129.958700413003, 4133.9173216535655, 4137.793110344471, 4146.730462519927, 4031.7782521961426, 4084.7549147051272, 4092.4270602115726, 4107.774072426016, 4110.28070087735, 3600.819959002066, 3601.2977469393477, 3601.5678118625933, 3617.2042150726797, 3620.746547741659, 5082.0, 5105.412877519096, 5118.820841270538, 5119.334486516729, 5135.74321283938, 4566.429196350457, 4753.786079626425, 4764.404449443819, 4764.97553026101, 4765.666403351766, 5587.636803607753, 5598.384177740445, 5599.804006859781, 5605.523530499912, 5632.324121105453, 3934.8426062957733, 3956.4658771065824, 3959.3269144245546, 3968.444417781513, 3968.5436174839974, 5556.91664625031, 5913.142594323799, 5924.763009479616, 5935.2877654681715, 5942.821715348547, 3945.822437990297, 3977.661898738582, 3986.740861843971, 3991.5409727881083, 4001.579834117434, 4051.331530297527, 4054.2904991626347, 4058.2086493134148, 4065.10567675111, 4078.5513593504693, 4603.838865639686, 4671.392718946515, 4673.556012178838, 4683.695559788603, 4686.6485013624115, 5651.095824668033, 5659.5755318351285, 5663.329317851244, 5667.0, 5670.5463562914865, 1393.7769956806862, 1408.0777091005407, 1408.1832537128441, 1409.9154050756988, 1413.8303403591428, 875.2166810704384, 902.6479672927563, 938.6855403439788, 959.7072892767773, 960.9951950240204, 4809.615230781529, 4821.975890120527, 4827.879303017453, 4834.564889159992, 4859.368282123372, 5719.227904232958, 5746.741396637161, 5748.223989761329, 5761.135829625506, 5766.481016708516, 4655.51117132703, 4783.210770222874, 4817.2774083887, 4820.855374338776, 4906.018796240766, 3116.407882502317, 3125.46867032605, 3145.433821912032, 3146.0, 3149.921251968719, 5468.7265636718, 5486.1222204447895, 5489.560835133179, 5495.725213739377, 5498.5876059295715, 5852.795152169653, 5914.9187060927825, 5948.732307046107, 5981.581289309794, 5987.101934709828, 5422.861199148223, 5453.700046497481, 5458.645188062763, 5483.533899618577, 5513.649155956736, 5639.182318563868, 5836.445537673914, 5839.386864379179, 5847.0, 5859.326177489644, 5730.312362516524, 5736.852629474039, 5739.2252045973255, 5753.884922301614, 5758.827235182951, 5470.589705772003, 5473.72631368422, 5476.288082549243, 5496.340439147328, 5516.365617953827, 3928.4303775951757, 3939.862104826317, 3967.4247234150307, 4007.1985602880122, 4020.7587544747407, 5801.506871915765, 5818.389069147848, 5823.534117270693, 5851.385604511635, 5869.853253668693, 5597.3003374578175, 5613.456299517502, 5644.717764111696, 5657.349404818498, 5667.914981275367, 5487.052096505683, 5583.2462617547735, 5619.943800561942, 5636.605437619327, 5637.46444087811, 5247.02929957959, 5521.365043019943, 5526.226328313959, 5548.417416171405, 5552.444755524415, 5439.782408703608, 5662.716864156693, 5667.943320566742, 5676.318841739017, 5688.431156884279, 5524.530414914777, 5543.52880005204, 5550.361708403585, 5555.666660000413, 5579.609427340048], "value": 4202.335287440363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.5932518464477, 736.561745761272, 769.3460558525253, 781.3788038509388, 786.6027656033702, 11398.829017564733, 11603.303801771879, 11628.360440175788, 11664.883351166485, 11669.883301166985, 11236.66290011299, 11309.943450282757, 11963.521459141646, 12583.0, 12625.305608191546, 803.1887793328722, 805.697863301262, 807.8263173417714, 808.3613944983456, 810.6959890041235, 641.6086187425667, 794.0947320055113, 800.1358532784578, 801.7193982106245, 807.9798005049892, 841.8148007438384, 844.3034496540348, 846.2510678049908, 850.1286181663783, 850.4387104511025, 830.5930094253832, 838.1074156023815, 839.7858546070744, 840.6637345061963, 841.4530555139147, 610.3957082488305, 611.7552978808512, 613.1048668943348, 613.2457077794294, 613.6011592464889, 11609.709757256052, 11634.0, 11679.065674746085, 12126.211796233305, 12133.878661213363, 12917.354132293347, 13097.148685335518, 13124.803127953088, 13149.342532873414, 13473.797893031613, 10135.543900524493, 10241.436720980342, 10284.845727314021, 10291.331063480924, 10404.063634272876, 3333.749968752329, 3367.2087059540986, 3389.2713066690535, 3392.23674673199, 3472.73954453417, 47807.760961195316, 48110.759446202894, 48236.517634823904, 48254.0, 48261.75869120632, 10289.713785776778, 10387.0, 10439.321444106108, 10544.314619549705, 10645.0, 18070.457886263433, 18211.362602308855, 18416.079196040144, 18469.7229541557, 18524.44426667202, 7283.635818209068, 7356.632168391559, 7416.555006699507, 7431.405487560982, 7463.14173870001, 3893.260280546687, 3952.9011774705864, 3996.9200615987515, 4014.2573623879093, 4027.436158937751, 2869.6126022986628, 2947.3073827650487, 2949.277427030391, 2950.247686839842, 2966.5846781450614, 544.8801263721975, 560.344397055438, 560.6215804332141, 561.9213310136585, 595.7459547652217, 580.9273840769904, 594.088074805172, 610.4444955090935, 625.3902445115975, 647.1910112359551, 7959.787579582944, 8037.316828069563, 8042.195780421911, 8146.389020823462, 8575.699850505327, 501.99600798403196, 537.3739593373676, 583.2184872271177, 635.7266375458597, 650.3756393861851, 3976.5824588418377, 4006.0185254612807, 4048.757074575476, 4133.483314585676, 4234.237837189336, 57428.0, 57497.712511437174, 58120.709396452745, 58340.0, 58392.416075839545, 49120.0, 49852.25221621679, 49863.252051219264, 50517.49482505128, 50954.0, 45925.54074459212, 45983.77008114938, 46072.539274606825, 46174.769126154824, 46752.5324746755, 7659.272369124924, 7728.690852366068, 7788.571628560484, 7891.013623297088, 7946.205379462239, 29206.853965730035, 30077.0, 30433.23916902095, 30778.53832192474, 30902.22744431407, 37406.0, 40999.0, 41487.0, 41592.37611435771, 42189.0, 9770.951145244513, 9897.703068907944, 9903.0, 10098.495075246356, 10438.269321147447, 10149.39103653783, 10187.643432479828, 10467.214958877963, 10539.367637941748, 10608.0, 10021.198304135505, 10173.593056277961, 10214.336068155546, 10218.846717299099, 10265.384076955406, 10251.948740256252, 10278.25380630227, 10408.531616077446, 10525.36847789135, 10606.681799546026, 9775.364601300893, 9862.852057219005, 9950.651727189514, 9964.55159517838, 10290.588376464857, 8378.455400398954, 8402.831943360976, 8697.217250447236, 8732.170443807829, 8886.688965886164, 8848.292136629183, 8909.465432074096, 9024.684136055206, 9036.096390360912, 9243.352965292364], "value": 5979.089001663542, "unit": "score"}], "name": "dromaeo_css", "value": 6330.882157409704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 114.0, 112.0, 115.0, 124.0, 114.0, 116.0, 115.0, 112.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 136.0, 161.0, 172.0, 136.0, 157.0, 162.0, 133.0, 190.0, 133.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 169.0, 165.0, 167.0, 163.0, 164.0, 164.0, 164.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 161.0, 77.0, 75.0, 75.0, 76.0, 159.0, 74.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 145.0, 94.0, 95.0, 92.0, 137.0, 95.0, 94.0, 141.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 69.0, 66.0, 66.0, 69.0, 96.0, 63.0, 63.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 80.0, 81.0, 81.0, 79.0, 80.0, 89.0, 80.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 132.0, 140.0, 138.0, 137.0, 131.0, 136.0, 164.0, 139.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 177.0, 176.0, 177.0, 178.0, 170.0, 177.0, 174.0, 170.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 73.0, 74.0, 73.0, 72.0, 69.0, 73.0, 72.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1594.8, "alertThreshold": 2.0}]} 12:39:55 INFO - Return code: 0 12:39:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:39:55 ERROR - # TBPL SUCCESS # 12:39:55 INFO - Running post-action listener: _resource_record_post_action 12:39:55 INFO - Running post-run listener: _resource_record_post_run 12:39:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 499712; Write bytes: 286167040; Read time: 148; Write time: 231756 12:39:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5136384; Read time: 0; Write time: 376 12:39:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 499712; Write bytes: 281030656; Read time: 148; Write time: 231380 12:39:56 INFO - Running post-run listener: _upload_blobber_files 12:39:56 INFO - Blob upload gear active. 12:39:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:56 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 12:39:56 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'] 12:39:56 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 12:39:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:57 INFO - (blobuploader) - INFO - Done attempting. 12:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:58 INFO - (blobuploader) - INFO - Done attempting. 12:39:58 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:58 INFO - Return code: 0 12:39:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b39911f007b4fd3c06abd3905b42960d685b915ebb9b58a10768c1823d9b3b169e58cbf2e2534d8589e6c8232f6bd8af978ed7951eedf9828fc7e2246bd45200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aed93ab919b6e27b06aa6d1a9f8f2118a811dbc89ae603208ab9782b93c417f49380130c9c7d4178777d81f4c7f22015ae89c1f5f4a7e5490868ba9fbcbe7e3"} 12:39:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:58 INFO - Contents: 12:39:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b39911f007b4fd3c06abd3905b42960d685b915ebb9b58a10768c1823d9b3b169e58cbf2e2534d8589e6c8232f6bd8af978ed7951eedf9828fc7e2246bd45200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aed93ab919b6e27b06aa6d1a9f8f2118a811dbc89ae603208ab9782b93c417f49380130c9c7d4178777d81f4c7f22015ae89c1f5f4a7e5490868ba9fbcbe7e3"} 12:39:58 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:58 INFO - Copying logs to upload dir... 12:39:58 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.539257 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-15 12:39:58.215557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:39:58.219489) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b39911f007b4fd3c06abd3905b42960d685b915ebb9b58a10768c1823d9b3b169e58cbf2e2534d8589e6c8232f6bd8af978ed7951eedf9828fc7e2246bd45200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aed93ab919b6e27b06aa6d1a9f8f2118a811dbc89ae603208ab9782b93c417f49380130c9c7d4178777d81f4c7f22015ae89c1f5f4a7e5490868ba9fbcbe7e3"} build_url:https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/T9fIapH5SwixcWO7w_3GHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b39911f007b4fd3c06abd3905b42960d685b915ebb9b58a10768c1823d9b3b169e58cbf2e2534d8589e6c8232f6bd8af978ed7951eedf9828fc7e2246bd45200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8aed93ab919b6e27b06aa6d1a9f8f2118a811dbc89ae603208ab9782b93c417f49380130c9c7d4178777d81f4c7f22015ae89c1f5f4a7e5490868ba9fbcbe7e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:39:58.243476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:39:58.243764) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460746947.673797-1874216251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:39:58.325581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:39:58.325858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:39:58.326147) ========= ========= Total master_lag: 0.16 =========