builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1461633332.78 results: success (0) buildid: 20160425171313 builduid: 322e28ed6f0a4eb7be79f0296b909785 revision: cfc7ebe592937ad937cebe04fdad4213eee72fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.777715) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.778153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.778491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.797479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.797786) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 18:15:33-- 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% 110M=0s 2016-04-25 18:15:33 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.904342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.904669) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015925 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.959793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:32.960159) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cfc7ebe592937ad937cebe04fdad4213eee72fae --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 cfc7ebe592937ad937cebe04fdad4213eee72fae --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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 18:15:33,282 truncating revision to first 12 chars 2016-04-25 18:15:33,282 Setting DEBUG logging. 2016-04-25 18:15:33,282 attempt 1/10 2016-04-25 18:15:33,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cfc7ebe59293?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 18:15:33,531 unpacking tar archive at: mozilla-central-cfc7ebe59293/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548514 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:33.623656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:33.624038) ========= script_repo_revision: cfc7ebe592937ad937cebe04fdad4213eee72fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:33.624479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:33.624778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:15:33.648821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 18:15:33.649529) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:15:34 INFO - MultiFileLogger online at 20160425 18:15:34 in /builds/slave/test 18:15:34 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 18:15:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:15:34 INFO - {'append_to_log': False, 18:15:34 INFO - 'base_work_dir': '/builds/slave/test', 18:15:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:15:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:15:34 INFO - 'branch': 'Firefox-Non-PGO', 18:15:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:15:34 INFO - 'config_files': ('talos/linux_config.py',), 18:15:34 INFO - 'default_actions': ('clobber', 18:15:34 INFO - 'read-buildbot-config', 18:15:34 INFO - 'download-and-extract', 18:15:34 INFO - 'populate-webroot', 18:15:34 INFO - 'create-virtualenv', 18:15:34 INFO - 'install', 18:15:34 INFO - 'run-tests'), 18:15:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:15:34 INFO - 'download_minidump_stackwalk': True, 18:15:34 INFO - 'download_symbols': 'ondemand', 18:15:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:15:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:15:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:15:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:15:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:15:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:15:34 INFO - 'installer_path': 'installer.exe', 18:15:34 INFO - 'log_level': 'info', 18:15:34 INFO - 'log_name': 'talos', 18:15:34 INFO - 'log_to_console': True, 18:15:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:15:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:15:34 INFO - 'opt_config_files': (), 18:15:34 INFO - 'pip_index': False, 18:15:34 INFO - 'sps_profile': False, 18:15:34 INFO - 'sps_profile_interval': 0, 18:15:34 INFO - 'suite': 'dromaeojs-e10s', 18:15:34 INFO - 'system_bits': '32', 18:15:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:15:34 INFO - 'title': 'talos-linux64-ix-005', 18:15:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:15:34 INFO - 'use_talos_json': True, 18:15:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:15:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:15:34 INFO - 'work_dir': 'build'} 18:15:34 INFO - ##### 18:15:34 INFO - ##### Running clobber step. 18:15:34 INFO - ##### 18:15:34 INFO - Running pre-action listener: _resource_record_pre_action 18:15:34 INFO - Running main action method: clobber 18:15:34 INFO - rmtree: /builds/slave/test/build 18:15:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:15:35 INFO - Running post-action listener: _resource_record_post_action 18:15:35 INFO - ##### 18:15:35 INFO - ##### Running read-buildbot-config step. 18:15:35 INFO - ##### 18:15:35 INFO - Running pre-action listener: _resource_record_pre_action 18:15:35 INFO - Running main action method: read_buildbot_config 18:15:35 INFO - Using buildbot properties: 18:15:35 INFO - { 18:15:35 INFO - "project": "", 18:15:35 INFO - "product": "firefox", 18:15:35 INFO - "script_repo_revision": "production", 18:15:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:15:35 INFO - "repository": "", 18:15:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:15:35 INFO - "buildid": "20160425171313", 18:15:35 INFO - "pgo_build": "False", 18:15:35 INFO - "basedir": "/builds/slave/test", 18:15:35 INFO - "buildnumber": 37, 18:15:35 INFO - "slavename": "talos-linux64-ix-005", 18:15:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:15:35 INFO - "platform": "ubuntu64_hw", 18:15:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:15:35 INFO - "branch": "mozilla-central", 18:15:35 INFO - "repo_path": "mozilla-central", 18:15:35 INFO - "revision": "cfc7ebe592937ad937cebe04fdad4213eee72fae", 18:15:35 INFO - "stage_platform": "linux64", 18:15:35 INFO - "builduid": "322e28ed6f0a4eb7be79f0296b909785", 18:15:35 INFO - "slavebuilddir": "test" 18:15:35 INFO - } 18:15:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:15:35 INFO - Running post-action listener: _resource_record_post_action 18:15:35 INFO - ##### 18:15:35 INFO - ##### Running download-and-extract step. 18:15:35 INFO - ##### 18:15:35 INFO - Running pre-action listener: _resource_record_pre_action 18:15:35 INFO - Running main action method: download_and_extract 18:15:35 INFO - mkdir: /builds/slave/test/build/tests 18:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:35 INFO - https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:15:36 INFO - Downloaded 1361 bytes. 18:15:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:15:36 INFO - Using the following test package requirements: 18:15:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:15:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:15:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'jsshell-linux-x86_64.zip'], 18:15:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:15:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:15:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:15:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:15:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:15:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:36 INFO - https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:15:38 INFO - Downloaded 22289915 bytes. 18:15:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:15:39 INFO - Return code: 0 18:15:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:15: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')]} 18:15:39 INFO - https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:15:51 INFO - Downloaded 22289915 bytes. 18:15:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:15:52 INFO - Return code: 0 18:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:52 INFO - https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:15:53 INFO - Downloaded 10840145 bytes. 18:15:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:15:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:15:53 INFO - Return code: 0 18:15: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')]} 18:15:53 INFO - https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:15:55 INFO - Downloaded 54815348 bytes. 18:15:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:15:55 INFO - mkdir: /builds/slave/test/properties 18:15:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:15:55 INFO - Writing to file /builds/slave/test/properties/build_url 18:15:55 INFO - Contents: 18:15:55 INFO - build_url:https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:15:56 INFO - Running post-action listener: _resource_record_post_action 18:15:56 INFO - Running post-action listener: set_extra_try_arguments 18:15:56 INFO - ##### 18:15:56 INFO - ##### Running populate-webroot step. 18:15:56 INFO - ##### 18:15:56 INFO - Running pre-action listener: _resource_record_pre_action 18:15:56 INFO - Running main action method: populate_webroot 18:15:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:15:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:15:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:15:56 INFO - '--tppagecycles', 18:15:56 INFO - '7'], 18:15:56 INFO - 'tests': ['tsvgm']}}, 18:15:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:15:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:15:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:15:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:15:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['damp', 'tps']}, 18:15:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'tests': ['damp', 'tps']}, 18:15:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['dromaeo_dom']}, 18:15:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:15:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'other-e10s': {'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['a11yr', 18:15:56 INFO - 'ts_paint', 18:15:56 INFO - 'tpaint', 18:15:56 INFO - 'sessionrestore', 18:15:56 INFO - 'sessionrestore_no_auto_restore', 18:15:56 INFO - 'tabpaint']}, 18:15:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['tsvgx', 18:15:56 INFO - 'tsvgr_opacity', 18:15:56 INFO - 'tart', 18:15:56 INFO - 'tscrollx', 18:15:56 INFO - 'cart']}, 18:15:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:15:56 INFO - 'tsvgr_opacity', 18:15:56 INFO - 'tart', 18:15:56 INFO - 'tscrollx', 18:15:56 INFO - 'cart']}, 18:15:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'talos_options': ['--disable-e10s'], 18:15:56 INFO - 'tests': ['tp5o']}, 18:15:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'tests': ['tp5o']}, 18:15:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'talos_options': ['--disable-e10s', 18:15:56 INFO - '--xperf_path', 18:15:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:56 INFO - 'tests': ['tp5n']}, 18:15:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:56 INFO - 'talos_options': ['--xperf_path', 18:15:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:56 INFO - 'tests': ['tp5n']}}, 18:15:56 INFO - 'talos.zip': {'path': '', 18:15:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:15:56 INFO - Running post-action listener: _resource_record_post_action 18:15:56 INFO - ##### 18:15:56 INFO - ##### Running create-virtualenv step. 18:15:56 INFO - ##### 18:15:56 INFO - Running pre-action listener: _resource_record_pre_action 18:15:56 INFO - Running main action method: create_virtualenv 18:15:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:15:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:15:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:15:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:15:56 INFO - Using real prefix '/usr' 18:15:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:15:57 INFO - Installing distribute.............................................................................................................................................................................................done. 18:15:59 INFO - Installing pip.................done. 18:15:59 INFO - Return code: 0 18:15:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:59 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:15:59 INFO - Using env: {'DISPLAY': ':0', 18:15:59 INFO - 'HOME': '/home/cltbld', 18:15:59 INFO - 'LANG': 'en_US.UTF-8', 18:15:59 INFO - 'LANGUAGE': 'en_US:en', 18:15:59 INFO - 'LOGNAME': 'cltbld', 18:15:59 INFO - 'MAIL': '/var/mail/cltbld', 18:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:59 INFO - 'MOZ_NO_REMOTE': '1', 18:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:59 INFO - 'NO_EM_RESTART': '1', 18:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:59 INFO - 'PWD': '/builds/slave/test', 18:15:59 INFO - 'SHELL': '/bin/bash', 18:15:59 INFO - 'SHLVL': '1', 18:15:59 INFO - 'TERM': 'linux', 18:15:59 INFO - 'TMOUT': '86400', 18:15:59 INFO - 'USER': 'cltbld', 18:15:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:59 INFO - '_': '/tools/buildbot/bin/python'} 18:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:15:59 INFO - Cleaning up... 18:15:59 INFO - Return code: 0 18:15:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:59 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:59 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 18:15:59 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 18:15:59 INFO - Using env: {'DISPLAY': ':0', 18:15:59 INFO - 'HOME': '/home/cltbld', 18:15:59 INFO - 'LANG': 'en_US.UTF-8', 18:15:59 INFO - 'LANGUAGE': 'en_US:en', 18:15:59 INFO - 'LOGNAME': 'cltbld', 18:15:59 INFO - 'MAIL': '/var/mail/cltbld', 18:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:59 INFO - 'MOZ_NO_REMOTE': '1', 18:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:59 INFO - 'NO_EM_RESTART': '1', 18:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:59 INFO - 'PWD': '/builds/slave/test', 18:15:59 INFO - 'SHELL': '/bin/bash', 18:15:59 INFO - 'SHLVL': '1', 18:15:59 INFO - 'TERM': 'linux', 18:15:59 INFO - 'TMOUT': '86400', 18:15:59 INFO - 'USER': 'cltbld', 18:15:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:59 INFO - '_': '/tools/buildbot/bin/python'} 18:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:59 INFO - Downloading/unpacking psutil>=0.7.1 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:01 INFO - Installing collected packages: psutil 18:16:01 INFO - Running setup.py install for psutil 18:16:01 INFO - building 'psutil._psutil_linux' extension 18:16:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:16:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:16:01 INFO - building 'psutil._psutil_posix' extension 18:16:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:16:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:02 INFO - Successfully installed psutil 18:16:02 INFO - Cleaning up... 18:16:02 INFO - Return code: 0 18:16:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:02 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 18:16:02 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 18:16:02 INFO - Using env: {'DISPLAY': ':0', 18:16:02 INFO - 'HOME': '/home/cltbld', 18:16:02 INFO - 'LANG': 'en_US.UTF-8', 18:16:02 INFO - 'LANGUAGE': 'en_US:en', 18:16:02 INFO - 'LOGNAME': 'cltbld', 18:16:02 INFO - 'MAIL': '/var/mail/cltbld', 18:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:02 INFO - 'MOZ_NO_REMOTE': '1', 18:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:02 INFO - 'NO_EM_RESTART': '1', 18:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:02 INFO - 'PWD': '/builds/slave/test', 18:16:02 INFO - 'SHELL': '/bin/bash', 18:16:02 INFO - 'SHLVL': '1', 18:16:02 INFO - 'TERM': 'linux', 18:16:02 INFO - 'TMOUT': '86400', 18:16:02 INFO - 'USER': 'cltbld', 18:16:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:02 INFO - '_': '/tools/buildbot/bin/python'} 18:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:16:04 INFO - Installing collected packages: mozsystemmonitor 18:16:04 INFO - Running setup.py install for mozsystemmonitor 18:16:04 INFO - Successfully installed mozsystemmonitor 18:16:04 INFO - Cleaning up... 18:16:04 INFO - Return code: 0 18:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:04 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:16:04 INFO - Using env: {'DISPLAY': ':0', 18:16:04 INFO - 'HOME': '/home/cltbld', 18:16:04 INFO - 'LANG': 'en_US.UTF-8', 18:16:04 INFO - 'LANGUAGE': 'en_US:en', 18:16:04 INFO - 'LOGNAME': 'cltbld', 18:16:04 INFO - 'MAIL': '/var/mail/cltbld', 18:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:04 INFO - 'MOZ_NO_REMOTE': '1', 18:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:04 INFO - 'NO_EM_RESTART': '1', 18:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:04 INFO - 'PWD': '/builds/slave/test', 18:16:04 INFO - 'SHELL': '/bin/bash', 18:16:04 INFO - 'SHLVL': '1', 18:16:04 INFO - 'TERM': 'linux', 18:16:04 INFO - 'TMOUT': '86400', 18:16:04 INFO - 'USER': 'cltbld', 18:16:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:04 INFO - '_': '/tools/buildbot/bin/python'} 18:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:07 INFO - Downloading docopt-0.6.1.tar.gz 18:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:07 INFO - Running setup.py install for blobuploader 18:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:16:07 INFO - Running setup.py install for requests 18:16:07 INFO - Running setup.py install for docopt 18:16:07 INFO - Successfully installed blobuploader requests docopt 18:16:07 INFO - Cleaning up... 18:16:07 INFO - Return code: 0 18:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:07 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:07 INFO - Using env: {'DISPLAY': ':0', 18:16:07 INFO - 'HOME': '/home/cltbld', 18:16:07 INFO - 'LANG': 'en_US.UTF-8', 18:16:07 INFO - 'LANGUAGE': 'en_US:en', 18:16:07 INFO - 'LOGNAME': 'cltbld', 18:16:07 INFO - 'MAIL': '/var/mail/cltbld', 18:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:07 INFO - 'MOZ_NO_REMOTE': '1', 18:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:07 INFO - 'NO_EM_RESTART': '1', 18:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:07 INFO - 'PWD': '/builds/slave/test', 18:16:07 INFO - 'SHELL': '/bin/bash', 18:16:07 INFO - 'SHLVL': '1', 18:16:07 INFO - 'TERM': 'linux', 18:16:07 INFO - 'TMOUT': '86400', 18:16:07 INFO - 'USER': 'cltbld', 18:16:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:07 INFO - '_': '/tools/buildbot/bin/python'} 18:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:08 INFO - Running setup.py (path:/tmp/pip-MBi8Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:08 INFO - Running setup.py (path:/tmp/pip-zbZNKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:08 INFO - Running setup.py (path:/tmp/pip-lVx3ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:08 INFO - Running setup.py (path:/tmp/pip-soAPwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:08 INFO - Running setup.py (path:/tmp/pip-klwxVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:08 INFO - Running setup.py (path:/tmp/pip-vsiHuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:08 INFO - Running setup.py (path:/tmp/pip-se2jqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:08 INFO - Running setup.py (path:/tmp/pip-sJ7vPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:08 INFO - Running setup.py (path:/tmp/pip-VcLhjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:08 INFO - Running setup.py (path:/tmp/pip-2v1pwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:08 INFO - Running setup.py (path:/tmp/pip-vqsNM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:08 INFO - Running setup.py (path:/tmp/pip-ohRzUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:09 INFO - Running setup.py (path:/tmp/pip-TR0q85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:09 INFO - Running setup.py (path:/tmp/pip-k_rjBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:09 INFO - Running setup.py (path:/tmp/pip-5wt3bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:09 INFO - Running setup.py (path:/tmp/pip-iEzoXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:09 INFO - Running setup.py (path:/tmp/pip-ueCfGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:09 INFO - Running setup.py install for manifestparser 18:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:16:09 INFO - Running setup.py install for mozcrash 18:16:09 INFO - Running setup.py install for mozdebug 18:16:09 INFO - Running setup.py install for mozdevice 18:16:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:16:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:16:09 INFO - Running setup.py install for mozfile 18:16:09 INFO - Running setup.py install for mozhttpd 18:16:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:16:09 INFO - Running setup.py install for mozinfo 18:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for mozInstall 18:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for mozleak 18:16:10 INFO - Running setup.py install for mozlog 18:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for moznetwork 18:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for mozprocess 18:16:10 INFO - Running setup.py install for mozprofile 18:16:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for mozrunner 18:16:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:16:10 INFO - Running setup.py install for mozscreenshot 18:16:10 INFO - Running setup.py install for moztest 18:16:11 INFO - Running setup.py install for mozversion 18:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:11 INFO - Cleaning up... 18:16:11 INFO - Return code: 0 18:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:11 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:11 INFO - Using env: {'DISPLAY': ':0', 18:16:11 INFO - 'HOME': '/home/cltbld', 18:16:11 INFO - 'LANG': 'en_US.UTF-8', 18:16:11 INFO - 'LANGUAGE': 'en_US:en', 18:16:11 INFO - 'LOGNAME': 'cltbld', 18:16:11 INFO - 'MAIL': '/var/mail/cltbld', 18:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:11 INFO - 'MOZ_NO_REMOTE': '1', 18:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:11 INFO - 'NO_EM_RESTART': '1', 18:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:11 INFO - 'PWD': '/builds/slave/test', 18:16:11 INFO - 'SHELL': '/bin/bash', 18:16:11 INFO - 'SHLVL': '1', 18:16:11 INFO - 'TERM': 'linux', 18:16:11 INFO - 'TMOUT': '86400', 18:16:11 INFO - 'USER': 'cltbld', 18:16:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:11 INFO - '_': '/tools/buildbot/bin/python'} 18:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:11 INFO - Running setup.py (path:/tmp/pip-yjB9hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:11 INFO - Running setup.py (path:/tmp/pip-mPSSRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:11 INFO - Running setup.py (path:/tmp/pip-5XKfNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:11 INFO - Running setup.py (path:/tmp/pip-d7ZsRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:11 INFO - Running setup.py (path:/tmp/pip-N16ZYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:11 INFO - Running setup.py (path:/tmp/pip-mdsLwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:11 INFO - Running setup.py (path:/tmp/pip-VUb_hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:11 INFO - Running setup.py (path:/tmp/pip-t2aU2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:11 INFO - Running setup.py (path:/tmp/pip-MtZrP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:11 INFO - Running setup.py (path:/tmp/pip-HOxC8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:12 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)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:12 INFO - Running setup.py (path:/tmp/pip-Zw5ZYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:12 INFO - Running setup.py (path:/tmp/pip-Ir0oUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:12 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)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:12 INFO - Running setup.py (path:/tmp/pip-GnaHmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:12 INFO - Running setup.py (path:/tmp/pip-9E2hKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:12 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)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:12 INFO - Running setup.py (path:/tmp/pip-5ur3kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:12 INFO - Running setup.py (path:/tmp/pip-b_kvqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:12 INFO - Running setup.py (path:/tmp/pip-k1VOZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:14 INFO - Downloading blessings-1.6.tar.gz 18:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:14 INFO - Installing collected packages: blessings 18:16:14 INFO - Running setup.py install for blessings 18:16:14 INFO - Successfully installed blessings 18:16:14 INFO - Cleaning up... 18:16:14 INFO - Return code: 0 18:16:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:14 INFO - Reading from file tmpfile_stdout 18:16:14 INFO - Current package versions: 18:16:14 INFO - argparse == 1.2.1 18:16:14 INFO - blessings == 1.6 18:16:14 INFO - blobuploader == 1.2.4 18:16:14 INFO - docopt == 0.6.1 18:16:14 INFO - manifestparser == 1.1 18:16:14 INFO - mozInstall == 1.12 18:16:14 INFO - mozcrash == 0.17 18:16:14 INFO - mozdebug == 0.1 18:16:14 INFO - mozdevice == 0.48 18:16:14 INFO - mozfile == 1.2 18:16:14 INFO - mozhttpd == 0.7 18:16:14 INFO - mozinfo == 0.9 18:16:14 INFO - mozleak == 0.1 18:16:14 INFO - mozlog == 3.1 18:16:14 INFO - moznetwork == 0.27 18:16:14 INFO - mozprocess == 0.22 18:16:14 INFO - mozprofile == 0.28 18:16:14 INFO - mozrunner == 6.11 18:16:14 INFO - mozscreenshot == 0.1 18:16:14 INFO - mozsystemmonitor == 0.0 18:16:14 INFO - moztest == 0.7 18:16:14 INFO - mozversion == 1.4 18:16:14 INFO - psutil == 3.1.1 18:16:14 INFO - requests == 1.2.3 18:16:14 INFO - wsgiref == 0.1.2 18:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:14 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:14 INFO - Using env: {'DISPLAY': ':0', 18:16:14 INFO - 'HOME': '/home/cltbld', 18:16:14 INFO - 'LANG': 'en_US.UTF-8', 18:16:14 INFO - 'LANGUAGE': 'en_US:en', 18:16:14 INFO - 'LOGNAME': 'cltbld', 18:16:14 INFO - 'MAIL': '/var/mail/cltbld', 18:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:14 INFO - 'MOZ_NO_REMOTE': '1', 18:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:14 INFO - 'NO_EM_RESTART': '1', 18:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:14 INFO - 'PWD': '/builds/slave/test', 18:16:14 INFO - 'SHELL': '/bin/bash', 18:16:14 INFO - 'SHLVL': '1', 18:16:14 INFO - 'TERM': 'linux', 18:16:14 INFO - 'TMOUT': '86400', 18:16:14 INFO - 'USER': 'cltbld', 18:16:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:14 INFO - '_': '/tools/buildbot/bin/python'} 18:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:16:15 INFO - Cleaning up... 18:16:15 INFO - Return code: 0 18:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:15 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:16:15 INFO - Using env: {'DISPLAY': ':0', 18:16:15 INFO - 'HOME': '/home/cltbld', 18:16:15 INFO - 'LANG': 'en_US.UTF-8', 18:16:15 INFO - 'LANGUAGE': 'en_US:en', 18:16:15 INFO - 'LOGNAME': 'cltbld', 18:16:15 INFO - 'MAIL': '/var/mail/cltbld', 18:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:15 INFO - 'MOZ_NO_REMOTE': '1', 18:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:15 INFO - 'NO_EM_RESTART': '1', 18:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:15 INFO - 'PWD': '/builds/slave/test', 18:16:15 INFO - 'SHELL': '/bin/bash', 18:16:15 INFO - 'SHLVL': '1', 18:16:15 INFO - 'TERM': 'linux', 18:16:15 INFO - 'TMOUT': '86400', 18:16:15 INFO - 'USER': 'cltbld', 18:16:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:15 INFO - '_': '/tools/buildbot/bin/python'} 18:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:15 INFO - Downloading/unpacking jsonschema 18:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:16:17 INFO - Downloading/unpacking functools32 (from jsonschema) 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:17 INFO - Downloading functools32-3.2.3-2.tar.gz 18:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:16:17 INFO - warning: no files found matching '*.txt' 18:16:17 INFO - no previously-included directories found matching 'build' 18:16:17 INFO - no previously-included directories found matching 'dist' 18:16:17 INFO - no previously-included directories found matching '.git*' 18:16:17 INFO - Installing collected packages: jsonschema, functools32 18:16:17 INFO - Running setup.py install for functools32 18:16:17 INFO - warning: no files found matching '*.txt' 18:16:17 INFO - no previously-included directories found matching 'build' 18:16:17 INFO - no previously-included directories found matching 'dist' 18:16:17 INFO - no previously-included directories found matching '.git*' 18:16:17 INFO - Successfully installed jsonschema functools32 18:16:17 INFO - Cleaning up... 18:16:17 INFO - Return code: 0 18:16:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:17 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 0x7fe68e098f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:17 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 18:16:17 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 18:16:17 INFO - Using env: {'DISPLAY': ':0', 18:16:17 INFO - 'HOME': '/home/cltbld', 18:16:17 INFO - 'LANG': 'en_US.UTF-8', 18:16:17 INFO - 'LANGUAGE': 'en_US:en', 18:16:17 INFO - 'LOGNAME': 'cltbld', 18:16:17 INFO - 'MAIL': '/var/mail/cltbld', 18:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:17 INFO - 'MOZ_NO_REMOTE': '1', 18:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:17 INFO - 'NO_EM_RESTART': '1', 18:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:17 INFO - 'PWD': '/builds/slave/test', 18:16:17 INFO - 'SHELL': '/bin/bash', 18:16:17 INFO - 'SHLVL': '1', 18:16:17 INFO - 'TERM': 'linux', 18:16:17 INFO - 'TMOUT': '86400', 18:16:17 INFO - 'USER': 'cltbld', 18:16:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:17 INFO - '_': '/tools/buildbot/bin/python'} 18:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:17 INFO - Downloading/unpacking flake8 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:16:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:16:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:20 INFO - no previously-included directories found matching 'docs/_build' 18:16:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:16:20 INFO - Running setup.py install for pep8 18:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:16:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:16:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:16:20 INFO - no previously-included directories found matching 'docs/_build' 18:16:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:16:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:16:20 INFO - Cleaning up... 18:16:20 INFO - Return code: 0 18:16:20 INFO - Running post-action listener: _resource_record_post_action 18:16:20 INFO - Running post-action listener: _start_resource_monitoring 18:16:20 INFO - Starting resource monitoring. 18:16:20 INFO - ##### 18:16:20 INFO - ##### Running install step. 18:16:20 INFO - ##### 18:16:20 INFO - Running pre-action listener: _resource_record_pre_action 18:16:20 INFO - Running main action method: install 18:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:20 INFO - Reading from file tmpfile_stdout 18:16:20 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:20 INFO - Reading from file tmpfile_stdout 18:16:20 INFO - Output received: 18:16:20 INFO - Usage: mozinstall [options] installer 18:16:20 INFO - Options: 18:16:20 INFO - -h, --help show this help message and exit 18:16:20 INFO - -d DEST, --destination=DEST 18:16:20 INFO - Directory to install application into. [default: 18:16:20 INFO - "/builds/slave/test"] 18:16:20 INFO - --app=APP Application being installed. [default: firefox] 18:16:20 INFO - mkdir: /builds/slave/test/build/application 18:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:16:36 INFO - Reading from file tmpfile_stdout 18:16:36 INFO - Output received: 18:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 18:16:36 INFO - Running post-action listener: _resource_record_post_action 18:16:36 INFO - ##### 18:16:36 INFO - ##### Running run-tests step. 18:16:36 INFO - ##### 18:16:36 INFO - Running pre-action listener: _resource_record_pre_action 18:16:36 INFO - Running main action method: run_tests 18:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:16:36 INFO - Python 2.7.3 18:16:36 INFO - Return code: 0 18:16:36 INFO - grabbing minidump binary from tooltool 18:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:36 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 0x2408410>, '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 0x2409310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:16:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:16:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:16:36 INFO - Return code: 0 18:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:16:37 INFO - Return code: 0 18:16:37 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/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 18:16:37 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/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 18:16:37 INFO - Using env: {'DISPLAY': ':0', 18:16:37 INFO - 'HOME': '/home/cltbld', 18:16:37 INFO - 'LANG': 'en_US.UTF-8', 18:16:37 INFO - 'LANGUAGE': 'en_US:en', 18:16:37 INFO - 'LOGNAME': 'cltbld', 18:16:37 INFO - 'MAIL': '/var/mail/cltbld', 18:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:37 INFO - 'MOZ_NO_REMOTE': '1', 18:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:37 INFO - 'NO_EM_RESTART': '1', 18:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:37 INFO - 'PWD': '/builds/slave/test', 18:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:16:37 INFO - 'SHELL': '/bin/bash', 18:16:37 INFO - 'SHLVL': '1', 18:16:37 INFO - 'TERM': 'linux', 18:16:37 INFO - 'TMOUT': '86400', 18:16:37 INFO - 'USER': 'cltbld', 18:16:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584', 18:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:37 INFO - '_': '/tools/buildbot/bin/python'} 18:16:37 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/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 18:16:37 INFO - mozversion application_buildid: 20160425171313 18:16:37 INFO - mozversion application_changeset: cfc7ebe592937ad937cebe04fdad4213eee72fae 18:16:37 INFO - mozversion application_display_name: Nightly 18:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:16:37 INFO - mozversion application_name: Firefox 18:16:37 INFO - mozversion application_remotingname: firefox 18:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:16:37 INFO - mozversion application_vendor: Mozilla 18:16:37 INFO - mozversion application_version: 49.0a1 18:16:37 INFO - mozversion platform_buildid: 20160425171313 18:16:37 INFO - mozversion platform_changeset: cfc7ebe592937ad937cebe04fdad4213eee72fae 18:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:16:37 INFO - mozversion platform_version: 49.0a1 18:16:37 INFO - using testdate: 1461633397 18:16:37 INFO - actual date: 1461633397 18:16:37 INFO - starting webserver on 'localhost:57410' 18:16:37 INFO - SUITE-START | Running 2 tests 18:16:37 INFO - TEST-START | dromaeo_css 18:16:37 INFO - operating with platform_type : linux_ 18:16:37 INFO - Initialising browser for dromaeo_css test... 18:16:37 INFO - TEST-INFO | started process 22247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFXtcyg/profile http://localhost:57410/getInfo.html) 18:16:41 INFO - PROCESS | 22247 | 18:16:41 INFO - PROCESS | 22247 | (process:22315): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:16:42 INFO - PROCESS | 22247 | __metrics Screen width/height:1600/1200 18:16:42 INFO - PROCESS | 22247 | colorDepth:24 18:16:42 INFO - PROCESS | 22247 | Browser inner width/height: 1024/697 18:16:42 INFO - PROCESS | 22247 | __metrics 18:16:43 ERROR - PROCESS | 22247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:16:44 INFO - TEST-INFO | 22247: exit 0 18:16:44 INFO - Browser initialized. 18:16:44 INFO - Running cycle 1/1 for dromaeo_css test... 18:16:44 INFO - TEST-INFO | started process 22366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFXtcyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:46 INFO - PROCESS | 22366 | 18:16:46 INFO - PROCESS | 22366 | (process:22428): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:16:56 INFO - PROCESS | 22366 | RSS: Main: 166436864 18:16:56 INFO - PROCESS | 22366 | 18:17:45 INFO - PROCESS | 22366 | 1461633465791 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:19:57 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57410/tests/dromaeo/cssquery-ext.html) 18:19:58 INFO - PROCESS | 22366 | RSS: Main: 169345024 18:19:58 INFO - PROCESS | 22366 | 18:23:00 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-ext.html (next: http://localhost:57410/tests/dromaeo/cssquery-jquery.html) 18:23:00 INFO - PROCESS | 22366 | RSS: Main: 166813696 18:23:00 INFO - PROCESS | 22366 | 18:26:02 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57410/tests/dromaeo/cssquery-mootools.html) 18:26:03 INFO - PROCESS | 22366 | RSS: Main: 167731200 18:26:03 INFO - PROCESS | 22366 | 18:29:05 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57410/tests/dromaeo/cssquery-prototype.html) 18:29:05 INFO - PROCESS | 22366 | RSS: Main: 165449728 18:29:05 INFO - PROCESS | 22366 | 18:32:08 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57410/tests/dromaeo/cssquery-yui.html) 18:32:09 INFO - PROCESS | 22366 | RSS: Main: 166526976 18:32:09 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | Cycle 1(1): loaded http://localhost:57410/tests/dromaeo/cssquery-yui.html (next: http://localhost:57410/tests/dromaeo/cssquery-dojo.html) 18:35:11 INFO - PROCESS | 22366 | RSS: Main: 168701952 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | __start_tp_report 18:35:11 INFO - PROCESS | 22366 | _x_x_mozilla_page_load 18:35:11 INFO - PROCESS | 22366 | _x_x_mozilla_page_load_details 18:35:11 INFO - PROCESS | 22366 | |i|pagename|runs| 18:35:11 INFO - PROCESS | 22366 | |0;dojo.html;2573.98713006435;2655.389260470092;2659.0693257359926;2661.36127329441;2686.328417895525;4696.953030469695;4698.060387922416;4723.976380118099;4742.7865746041425;4774.474807771151;4570.154521413541;4686.695364801286;4696.671233013691;4731.479537250908;4785.138675038492;4343.066240758244;4414.073044660625;4425.291953287475;4431.335299705038;4431.756253406062;619.0776498186392;4209.074003719177;4274.380214868842;4316.913661726763;4325.243082460573;4276.273033584267;4284.592963668447;4295.806688699016;4300.35494675798;4308.4399028126145;4245.8513952011845;4256.170046840867;4265.360195970629;4280.807363668642;4284.464441944757;4226.429432026698;4291;4333.046729719456;4377.956220437787;4400.031992961543;4585.426821647294;4607.308903664477;4615.699979501322;4620.214563524175;4678.508756580578;4984.800607975677;5022.271770593244;5029.396472423333;5035.269885866565;5073.974630126862;4923.040007198598;5058.165402708549;5104.438511763703;5147.613928955306;5154.484551544853;4713.1280713067845;4719.669623126382;4732.763361831963;4744.59670927975;4766.76166191689;5009.774560144802;5140.948590514122;5146;5168.457311982263;5191.039657663269;4900.215965445512;4918.139325618003;4960.131976904027;5007.273945277914;5027.120253955616;5058.9494105058475;5060.671056381397;5065.56942659878;5070.7464626768515;5113.616478764107;4783.521647835259;4985.351904252424;4994.300797888299;4996.6502344836235;4998.650094493423;4917;4938.851834444972;4995.800167993312;4999.775010124553;5039.823606173766;4211.7262377945335;4256.659467242614;4261.509926358509;4286.935695964563;4294.463192100988;3602.0994751312173;3723.5345581802276;3734.645208705223;3742.139307959185;3774.358359078963;4170.395292682605;4303.462067241595;4337.82648694055;4401.603855653007;4441.911161776747;4971.801127954841;4976.527229913152;4982.6512144149565;4997.775100120503;5027.648064635514;4247.617714405718;4298.226319262562;4298.742075475481;4311.943573824433;4338.327559228324;4479.17135329965;4516.23224051912;4532.410786597788;4540.477845047796;4561.110583436198;4723.834665786681;4761.976190119166;4767.785449654774;4775.498572649822;4778.402699662543;4813.326134341125;5068.315777370155;5080.136376815876;5083.745812709423;5112.105381558138;4769.2130798417875;4772;4808.374911261653;4838.443578988461;4845.345878306524;5036.269740887624;5057.089723849743;5065.8733531662;5066.645334826527;5113.258577506315;4930.630202734881;4948.430930443045;5080.085584594808;5139.280500729976;5183.222516622537;4919.458859525521;4929.383827021622;4931.9753401232765;4935.259711043373;4978.5519303261435;4884.65807393479;4902.92645610309;4916.410030796327;4925.975370123269;4968.503149685002;4669.836555720533;4734.17151998392;4840.854774356775;4844.781984810763;4905.852824415273;4894.902101958012;4902.093112774148;4909.607231421549;4916.213405855189;4955.578775803953;4783.234682450791;4804.711717296974;4805.231163013901;4811.446683631287;4864.440589332272 18:35:11 INFO - PROCESS | 22366 | |1;ext.html;578.7164289498145;607.7508221629132;625.2278436131377;626.8464226264563;630.1335663462738;27695.861520692393;35604.64395356046;36002.819985900096;36137.27725445489;36260.81869590651;37982;38678.4198237026;38699.61300387002;38713.22573548527;38757.612423875755;7671.424643151758;7808.60956952153;7829.451938364316;7852.411069169807;7862.724804631839;7600.467967242295;7732.845343093135;7755.1469338372735;7796.1814009529035;7938.880916786224;7923.524588524707;7947.7218297359605;7971.800704982364;8003.67985280591;8007.67969281228;7957.5225486471;7993.040835099767;7997.560134192617;8006.479578827358;8012.359011279113;7881.211878812131;7939.245771651684;7957.283844454027;7988.640511176953;8021.318187954031;38060.429093563616;38217.0445738856;38243.043923901845;38632.80683596564;38679.22641547153;3169.4770362890094;3187.378461200067;3239.5140728890856;3303.9174020649675;3454.936586291068;28319.858400707864;29009.12972610825;29186.854065729534;29703.851480742673;30722;3259.559959405474;3271.9509207361907;3290.3090351026312;3327.8835240766457;3398.8640454381793;236176;236515;237009;237412;237472;30491.2377190572;51351.486485135414;51754;52092;52160;31961;31994.520082198786;32048.679513205036;32123;32174;12393.504259829506;12641.115121941375;12748.681282967815;12758.55345062937;12769;10056.849147262797;10183.083522483012;10203.94898025505;10236;10252.948735256425;8080.39397045224;8145.714899978472;8190.54951977635;8244.051934027664;8303.086660467343;3214.7106760391675;3289.227031647561;3292.226326813197;3294.6870047345465;3323.5845519310087;907.9092090790868;927.9953600231955;929.4516235421135;992.3847214726916;1068.1828401273033;28780.424391512053;28969.275768105545;29101;29151;29312.413751724845;891.6210610490516;947.8009617980301;960.8894977077586;970.427447805798;1076.1767248055244;13419;13920.930395347958;14171.716565668628;14175.078619889675;14330.928345358207;344160;351028;352300;353476;353478;49443.50556494461;50156;50219;50586.494135058914;50630.24054639183;1193.4689063366718;1216.8260712083154;1226.9509219631116;1270.0474644016988;1270.8602053774262;25262.368440789127;27170;27411.31471713223;27552.173434796987;27762.444751105268;41294.1741165169;41520.1695966085;41561.1687766249;41571.58428415798;41663.37504937368;292017;294157;294536;296897;298613;25278.115265965604;25471.36321591975;25628.74371256338;25742;25745.227643170736;41724.24481796653;41904.58095419007;42388.152236955706;42872.571274286856;43073.353899690905;36517.81741091277;36543.45184822283;36939.44590831194;37129;37648.43527347147;35841;36572.63427365692;36636.26727465489;36673.44989825208;36869.63130368662;34929.30141397208;35083.473747893295;35519.64480355267;35890.46164307485;35895.923122306376;32236.677633223368;33044.339113218084;33913.96516209035;34137;34139.48790768091;25595.488090238465;25639.615405768556;25719.614205786555;25851.61222581625;25925 18:35:11 INFO - PROCESS | 22366 | |2;jquery.html;379.2301627695777;381.68892352732524;383.67579395410866;395.800120938926;401.861357831548;15512.534623961285;16658.750118748227;17237.310507579696;17249.827501724994;17260.654786904255;16742.83257167428;16904.323827046934;17369.652606947853;17410.129493525335;17452.214650340735;5107;5284.180951952453;5293.655912365703;5297.682139071649;5330.440303768107;3773.1510410157634;5774.3936886626925;6019.729112189962;6048.637081775108;6050.818475445722;5134.332536770234;5956.761729530814;5990.760369585233;5993.640381577119;6022.036474164134;5352.598555108343;5362.865928351784;5387.649802762808;5402.513773760361;5406.459354064582;5077.162268225738;5393.541548968343;5394.379646340682;5402.459754024605;5425.267588875491;12477.438515266835;12666.683332916751;12755;18156.45530634083;20913.477163070893;1809.9366721937001;1834.862385321093;1836.8714190006706;1874.3346112130134;1950.3368854589366;8641.179087986631;9421.670241541582;9426.811463770755;9682.854757178577;9729.708108756678;1727.7062899307023;1775.7336399540043;1803.4769916724135;1805.702059160237;1835.1191428114446;70015;71434;72435.63782181055;74405.62797186033;74790.25209747888;10070.798584028278;10182.694519164288;10379.948100259451;10446;10471;14519.346629401702;14522.85477145215;14523.128612283297;14595.562133136023;14610.123392596266;7327.194008659043;7562;7626.313631773167;7673.309402153722;7679.923200767921;7116.750913718099;7196.172440169447;7215.891761623579;7237.565746055148;7257.092863392076;4326.848560300375;4477.955220447819;4494.191045611821;4505.864824055284;4553.908921821545;1716.9399071032453;1752.5969027123579;1872.129459801199;1877.3804644467293;1914.2534411579495;863.9136086391311;945.9432434053979;948.5020364308793;951.8572214167792;1001.1390204424189;16332;16492.17539123039;16700.49898503047;16866.578335541464;16873.240704168344;851.7104184577273;860.4106187261746;862.4782006885869;876.0407353947545;878.2315473960285;9217.861732074025;9520.23838092951;9538.380005299634;9663.71008869721;9781.951090244504;335047;354821;355941;355993;357646;78052.60973695209;78154.76902227972;78932.21067789248;79895;80779.19220807716;876.9698148785541;878.7232021913205;896.5606852642159;903.9683611073581;905.1220316293185;14962.551376926722;15086.773698394314;15114.773278401053;15150.621234469227;15163;34354;35549.64450355567;35595;36048.81975590105;36918;46459;49210.753946231474;49997.50002499928;50393.244101339245;50575.49424505708;7487.925120748941;7581.583012934341;7598.164201937672;7736.381089512938;7758.107817600822;10378.42918639482;11137.888621114009;11168.441577921234;11219.382933938712;11414.828777568177;9121.315901307296;9835.16401105914;9914.256430767866;10087.646932357333;10263.486825658836;9680.322377433793;9828.066333698573;9964.551595178089;10004;10036.598536058476;9732.951335243279;9903.405795652285;10034.498275086362;10267.94866025665;10346.844797328196;7580;7636.923630763621;7642.541447513167;7665.655045523076;7752.108507521481;9352.812943741223;10078.092232718802;10178.083972442515;10231;10321.896781032094 18:35:11 INFO - PROCESS | 22366 | |3;mootools.html;1432.5487471446493;1451.0930668332292;1576.8659663928565;1723.35374234662;1770.34399529238;6392.169018027662;7259.782206533812;7352.485326027174;7625.161232264447;7649;7281.963590182055;7328.120625524931;7379.040724705781;7380.151282602503;7386.482946193769;2120.68189771534;2160.91356345746;2161.3083813179787;2161.3623980925586;2171.381156370435;2059.320424259998;2093.9581208375826;2116.3650904728597;2137.9893100534478;2146.8604540704805;2130.3502431758307;2134.8185404240658;2142.78572142786;2154.2029449103775;2168.739751229855;2083.6561967275456;2085.9061342239634;2086.9165233390722;2088.2064815370213;2091.832653387733;2085.666293393065;2154.9461263468384;2155.0302363936294;2163.177992362892;2174.1629472652985;7346.081739782528;7459.328660420588;7467.514611550286;7517.323440890292;7526.623668816537;4310.202612516695;4386.758728269944;4395.934060989088;4423.402840616508;4423.800928958204;2634.578467445219;2680.5175068487665;2778.4304217635336;2793.2318612381555;2813.8452385118812;910.5811326789685;915.56053094515;916.9220616247627;919.4988731141544;928.3223247029639;9538.380005299634;9719.757006074835;9730.172935300508;9799.363041402286;9799.363041402357;4108.383742438598;4139.8965025874595;4157.958420415817;4192.329227323614;4304.956950430518;8147.714829980922;8168.7957801055445;8209.630566624517;8213.425060245725;8231.300339471092;4557.840475583339;4560.931586026212;4567.223571992769;4584.037352156018;4587.3348364486965;3481.199324155408;4125.030617804873;4240.787960601958;4261.850835220753;4267.551907049778;3433.896983090511;3471.062813040465;3540.6636369544854;3552.8045957472586;3633.109888077438;1066.7599790047332;1078.0890147825075;1096.8245080787035;1102.1568500097433;1104.8011357955484;647.2976820150095;832.4297855968681;844.5523872347666;847.656699036891;878.2885862451435;4840.273958906122;5023.723695196799;5035.748212589356;5059.62052846038;5144.356955380577;399.3351070467639;403.73958796576045;407.4804624104291;425.8275398463627;436.6506794564336;3520.190356218084;3548.6451354864307;3561.4479755637917;3587.529113063684;3603.4414665726854;9182.77043073915;9452.43285402878;9551.14039736427;9570.856437153448;9587.280953928483;9170.67902623405;9390.295727820441;9428.434293942386;9441.527923603793;9513.096255855682;7217;7294.088238970129;7324.597147156957;7353.485256032133;7355.448341374418;4913.680610760289;5013.448520662651;5092.388913330424;5156.097682905552;5229.267902493578;8780.385373023826;8828.205461508238;8912.86630700527;8914.821703566022;8962.372633915564;8658.614621660505;8921.286297096087;8957.686480973134;9003.279737621106;9051.864222036544;6262.655553944394;6306.9684651576445;6350.872982540231;6383.691343274711;6424.582402143846;7070.080889484334;7110.32451917067;7111.928880711127;7126.928730712627;7138.072050633385;6217.09852071438;6271.3415091414745;6318;6490.253620833664;6534.248561415498;6631.502637302126;6639.7012134455035;6705.497087718343;6719;6775.051492791112;6282.277538082996;6295.476429188393;6388.9041664374145;6413.518986075969;6418.871622567429;4225.302825033835;4256.829726810893;4357.8038988246235;4396.208682437192;4416.425864637705;4220.303649897733;4351.521332653469;4388.05656783793;4415.6909016368545;4489.73061616304 18:35:11 INFO - PROCESS | 22366 | |4;prototype.html;308.1003469867985;308.5341134886322;309.1421305876195;309.77231734674996;315.04227149465623;4888.144574699427;4934.309196712463;4949.851504454868;4980.501949805027;5017.849464516061;4876.414830220369;4902.289168070628;4902.705837649743;4925.18734408823;4965.652404331699;3620.9275814483763;3737.439384092381;3895.7662540247534;3898.8050597470155;3921;3897.4348719435807;3900.882973510785;3903.1217975955465;3908.8241029153614;3913.1782325711633;3864.574896761354;3890.396988466792;3892.2215556888596;3900.746451480659;3901.51231096113;3788.7916164610933;3867.5165604299464;3869.5936926622862;3899.200663863901;3901.804909754501;3416.692497675196;3417.094469965461;3421.367047096295;3442.9655703442895;3450.068481509978;4709.458412282563;4730.243161094243;4730.716157030589;4740.431148262231;4751.14479393709;4412.3160910059;4432.268675668511;4443;4446.355278484634;4461.620762235214;4865.902681946377;5183.3002544656365;5204.959008198375;5206.895862082775;5224.817131400383;3662.359087159736;3672.540932383452;3676.8713095041544;3685.2261025184744;3685.7788532688123;5387.138057910715;5397.811076612339;5452.727363631802;5463.945360546383;5467.043267428224;3626.546681664792;3696.9075773105887;3697.574778900407;3708.4437334399518;3714.88855334335;3743.2139250757646;3761.962380376216;3777.0934975606206;3779.603141670085;3784.7918364489665;4311.741295522216;4348.108637729321;4355.869323920288;4356.934645980313;4363.345498175299;4992.425871024806;5171.7672704728375;5181.715005674724;5184.585233181337;5194.92207616886;1376.078027721429;1376.2361889151616;1377.7520046391746;1385.6951470676436;1391.2834890031643;853.7353420439683;901.8647202919483;922.8615707643772;937.9812403752023;939.2016785732073;4460.754658493749;4590.1737687215955;4594.977025114853;4605.378273933044;4606.89434535709;5378.865528361822;5381.623286369995;5381.704006279692;5402.594805389612;5433.1850222466155;4439.445069366329;4477.32840073985;4562.0191658792855;4589.678722489461;4614.861554153381;3028.8939887103847;3042.300270937697;3056.5720799088144;3059.8929037484027;3060.32672811981;5333.200019996954;5338.412774594792;5365.570754339644;5367.919481207785;5377.085895397791;5600.411956744565;5809.7095145242565;5830.7084645767545;5886.087656413263;5886.705664716747;5337.6797392156595;5341.679499229981;5358.624896257303;5367.168088946298;5371.274877891435;5704.572157088152;5740.655560666373;5746.655200687972;5772.567057470623;5773.913391299218;5427.782888684566;5649.745761440828;5662.688552129508;5665.971670141623;5672.517835983987;5351.59863010268;5374.984380857179;5377.059014672339;5392.514673679388;5412.215228791882;3860.285847118292;3886.7667939923695;3896.7856767876906;3900.6684431822478;3911.2373087247715;5097.439281678938;5374.596905232045;5379.085555455504;5394.676319420847;5397.136458166675;5236.9738151309;5245.790168393374;5246.42289348179;5256.369235691742;5256.685828542864;5083.975034854256;5114.258432527337;5147.176451767849;5209.661372010807;5219.217117432416;5132.640715149903;5146.150885103916;5163.870903227449;5178.326817513699;5179.430262671028;4972.65191436596;5087.389513258285;5219;5244.164542410126;5261.421243663271;5080.517350851663;5100.6429549931145;5120.436751957207;5126.769295381642;5152.639315247897 18:35:11 INFO - PROCESS | 22366 | |5;yui.html;622.8816524860276;635.2662674610823;687.2543290529775;695.0963747128732;748.8464864702737;12030.157888947777;12158.69603259919;12177.391130443486;12219.755604887909;12248.510059597616;11854.525818967231;11870.347130907818;12008.039356851452;12075.516979320839;12083.214591051597;652.4682383857165;780.6604127204656;812.7480481050878;822.5270469480043;826.8387664405413;821.8191997760513;829.3365307753803;829.3862541719114;831.1480732249432;832.026528961114;863.7020228021322;865.4590880699562;865.8787769712245;868.68727258187;869.7955980344614;850.9489430634181;857.34413173922;859.716293623106;860.5181098584782;862.5644049754897;626.1515646299245;627.8932581461163;627.9623222606658;630.4515071887441;631.902055181443;12259.387030648431;12312.81530777039;12380.690482738004;12391.194572352768;12394.070444716592;12972.221666700028;13035.478580856849;13091.149075310075;13337.533186338529;13600.523981660594;10366.792664146751;10375.584976600927;10404.843927341097;10560.683179504627;10616.57533698651;3338.3990881641294;3363.8486268117995;3373.2747459296124;3389.440742277521;3396;45412.77293613511;45500.77249613731;45627.315590266175;45657.54342456566;46853;9727.416355018722;9749.561269742879;9873.210143188528;9911.851322230172;9948.950255248677;17440.5639859002;17450.825491745174;17471.475855724348;17509.64980700379;17542.912285438746;6769.255381907986;6847.520673552903;6860.3139686031;6920.688569014406;7030.824229394306;3640.162762564625;3750.643688849555;3763.49192858966;3792;3856.3444214483607;2684.2752456836934;2746.491898998692;2769.418422131335;2776.583512473145;2780.6107144999714;505.6738403729647;509.31242822189745;513.8715321169708;515.1165750737504;519.6284656470642;515.8581390117672;645.1258544671902;662.6587307536622;663.0650782396893;663.8108139180407;7982.401319901031;8127.634256458474;8165.673373065129;8270.875936860952;8349.916500835036;586.5952492780053;611.4649681528663;621.4158690830604;621.5773274173605;654.0646874968841;3663.358912190356;3740.8690695825517;3796.487474191004;3811.1615444602144;3821.541415030214;54151.72924135354;54507.72746136323;54550;55078.44921550733;55348.446515535135;47730.5226947733;48092.519074809505;48304.03391932142;48507.5149248503;49127;42997.14005719868;43277.134457310676;43446.56553434425;43902.780486098;44135.33796992983;7547.849043019219;7613.505122167041;7681.884771728541;7709.768706938801;7719.228077192236;29214.853925730236;29479.55780663249;30018.849905750332;30941.226469338446;30965;36550.4517432244;39417.802910985265;39921.80039099786;40113.598864010986;40580;9851.802963940538;9948.343604778727;9950.950245248727;10001.399916005063;10040;10588.152947764007;10696.304740192174;10712.73218169552;10926.836097458703;11241.60654377093;9483.28875334339;9529.761755956157;9567.521623918916;9705.272104592324;9889.653862114792;9380.167957052325;9514.809703806024;9717;9816.754581135528;10403.063724264852;9154.26765858743;9479.668211612561;9522.285828563025;9605.279604029585;9788.608455661979;8755.168259015383;8824.691135810215;8911.37620366568;8915.73252802417;8950;9059;9096.54517274147;9130.452172869649;9153.86269205949;9159.954200228956 18:35:11 INFO - PROCESS | 22366 | __end_tp_report 18:35:11 INFO - PROCESS | 22366 | __start_cc_report 18:35:11 INFO - PROCESS | 22366 | _x_x_mozilla_cycle_collect,371 18:35:11 INFO - PROCESS | 22366 | __end_cc_report 18:35:11 INFO - PROCESS | 22366 | __startTimestamp1461634511673__endTimestamp 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | ------- Summary: start ------- 18:35:11 INFO - PROCESS | 22366 | Number of tests: 6 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#0] dojo.html Cycles:165 Average:4627.54 Median:4783.23 stddev:581.95 (12.2%) stddev-sans-first:560.99 18:35:11 INFO - PROCESS | 22366 | Values: 2574.0 2655.4 2659.1 2661.4 2686.3 4697.0 4698.1 4724.0 4742.8 4774.5 4570.2 4686.7 4696.7 4731.5 4785.1 4343.1 4414.1 4425.3 4431.3 4431.8 619.1 4209.1 4274.4 4316.9 4325.2 4276.3 4284.6 4295.8 4300.4 4308.4 4245.9 4256.2 4265.4 4280.8 4284.5 4226.4 4291.0 4333.0 4378.0 4400.0 4585.4 4607.3 4615.7 4620.2 4678.5 4984.8 5022.3 5029.4 5035.3 5074.0 4923.0 5058.2 5104.4 5147.6 5154.5 4713.1 4719.7 4732.8 4744.6 4766.8 5009.8 5140.9 5146.0 5168.5 5191.0 4900.2 4918.1 4960.1 5007.3 5027.1 5058.9 5060.7 5065.6 5070.7 5113.6 4783.5 4985.4 4994.3 4996.7 4998.7 4917.0 4938.9 4995.8 4999.8 5039.8 4211.7 4256.7 4261.5 4286.9 4294.5 3602.1 3723.5 3734.6 3742.1 3774.4 4170.4 4303.5 4337.8 4401.6 4441.9 4971.8 4976.5 4982.7 4997.8 5027.6 4247.6 4298.2 4298.7 4311.9 4338.3 4479.2 4516.2 4532.4 4540.5 4561.1 4723.8 4762.0 4767.8 4775.5 4778.4 4813.3 5068.3 5080.1 5083.7 5112.1 4769.2 4772.0 4808.4 4838.4 4845.3 5036.3 5057.1 5065.9 5066.6 5113.3 4930.6 4948.4 5080.1 5139.3 5183.2 4919.5 4929.4 4932.0 4935.3 4978.6 4884.7 4902.9 4916.4 4926.0 4968.5 4669.8 4734.2 4840.9 4844.8 4905.9 4894.9 4902.1 4909.6 4916.2 4955.6 4783.2 4804.7 4805.2 4811.4 4864.4 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#1] ext.html Cycles:180 Average:44041.46 Median:194498.82 stddev:78370.36 (40.3%) stddev-sans-first:78522.27 18:35:11 INFO - PROCESS | 22366 | Values: 578.7 607.8 625.2 626.8 630.1 27695.9 35604.6 36002.8 36137.3 36260.8 37982.0 38678.4 38699.6 38713.2 38757.6 7671.4 7808.6 7829.5 7852.4 7862.7 7600.5 7732.8 7755.1 7796.2 7938.9 7923.5 7947.7 7971.8 8003.7 8007.7 7957.5 7993.0 7997.6 8006.5 8012.4 7881.2 7939.2 7957.3 7988.6 8021.3 38060.4 38217.0 38243.0 38632.8 38679.2 3169.5 3187.4 3239.5 3303.9 3454.9 28319.9 29009.1 29186.9 29703.9 30722.0 3259.6 3272.0 3290.3 3327.9 3398.9 236176.0 236515.0 237009.0 237412.0 237472.0 30491.2 51351.5 51754.0 52092.0 52160.0 31961.0 31994.5 32048.7 32123.0 32174.0 12393.5 12641.1 12748.7 12758.6 12769.0 10056.8 10183.1 10203.9 10236.0 10252.9 8080.4 8145.7 8190.5 8244.1 8303.1 3214.7 3289.2 3292.2 3294.7 3323.6 907.9 928.0 929.5 992.4 1068.2 28780.4 28969.3 29101.0 29151.0 29312.4 891.6 947.8 960.9 970.4 1076.2 13419.0 13920.9 14171.7 14175.1 14330.9 344160.0 351028.0 352300.0 353476.0 353478.0 49443.5 50156.0 50219.0 50586.5 50630.2 1193.5 1216.8 1227.0 1270.0 1270.9 25262.4 27170.0 27411.3 27552.2 27762.4 41294.2 41520.2 41561.2 41571.6 41663.4 292017.0 294157.0 294536.0 296897.0 298613.0 25278.1 25471.4 25628.7 25742.0 25745.2 41724.2 41904.6 42388.2 42872.6 43073.4 36517.8 36543.5 36939.4 37129.0 37648.4 35841.0 36572.6 36636.3 36673.4 36869.6 34929.3 35083.5 35519.6 35890.5 35895.9 32236.7 33044.3 33914.0 34137.0 34139.5 25595.5 25639.6 25719.6 25851.6 25925.0 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#2] jquery.html Cycles:180 Average:23192.25 Median:50195.37 stddev:58507.20 (116.6%) stddev-sans-first:58646.25 18:35:11 INFO - PROCESS | 22366 | Values: 379.2 381.7 383.7 395.8 401.9 15512.5 16658.8 17237.3 17249.8 17260.7 16742.8 16904.3 17369.7 17410.1 17452.2 5107.0 5284.2 5293.7 5297.7 5330.4 3773.2 5774.4 6019.7 6048.6 6050.8 5134.3 5956.8 5990.8 5993.6 6022.0 5352.6 5362.9 5387.6 5402.5 5406.5 5077.2 5393.5 5394.4 5402.5 5425.3 12477.4 12666.7 12755.0 18156.5 20913.5 1809.9 1834.9 1836.9 1874.3 1950.3 8641.2 9421.7 9426.8 9682.9 9729.7 1727.7 1775.7 1803.5 1805.7 1835.1 70015.0 71434.0 72435.6 74405.6 74790.3 10070.8 10182.7 10379.9 10446.0 10471.0 14519.3 14522.9 14523.1 14595.6 14610.1 7327.2 7562.0 7626.3 7673.3 7679.9 7116.8 7196.2 7215.9 7237.6 7257.1 4326.8 4478.0 4494.2 4505.9 4553.9 1716.9 1752.6 1872.1 1877.4 1914.3 863.9 945.9 948.5 951.9 1001.1 16332.0 16492.2 16700.5 16866.6 16873.2 851.7 860.4 862.5 876.0 878.2 9217.9 9520.2 9538.4 9663.7 9782.0 335047.0 354821.0 355941.0 355993.0 357646.0 78052.6 78154.8 78932.2 79895.0 80779.2 877.0 878.7 896.6 904.0 905.1 14962.6 15086.8 15114.8 15150.6 15163.0 34354.0 35549.6 35595.0 36048.8 36918.0 46459.0 49210.8 49997.5 50393.2 50575.5 7487.9 7581.6 7598.2 7736.4 7758.1 10378.4 11137.9 11168.4 11219.4 11414.8 9121.3 9835.2 9914.3 10087.6 10263.5 9680.3 9828.1 9964.6 10004.0 10036.6 9733.0 9903.4 10034.5 10267.9 10346.8 7580.0 7636.9 7642.5 7665.7 7752.1 9352.8 10078.1 10178.1 10231.0 10321.9 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#3] mootools.html Cycles:180 Average:4948.47 Median:5076.00 stddev:2761.44 (54.4%) stddev-sans-first:2756.55 18:35:11 INFO - PROCESS | 22366 | Values: 1432.5 1451.1 1576.9 1723.4 1770.3 6392.2 7259.8 7352.5 7625.2 7649.0 7282.0 7328.1 7379.0 7380.2 7386.5 2120.7 2160.9 2161.3 2161.4 2171.4 2059.3 2094.0 2116.4 2138.0 2146.9 2130.4 2134.8 2142.8 2154.2 2168.7 2083.7 2085.9 2086.9 2088.2 2091.8 2085.7 2154.9 2155.0 2163.2 2174.2 7346.1 7459.3 7467.5 7517.3 7526.6 4310.2 4386.8 4395.9 4423.4 4423.8 2634.6 2680.5 2778.4 2793.2 2813.8 910.6 915.6 916.9 919.5 928.3 9538.4 9719.8 9730.2 9799.4 9799.4 4108.4 4139.9 4158.0 4192.3 4305.0 8147.7 8168.8 8209.6 8213.4 8231.3 4557.8 4560.9 4567.2 4584.0 4587.3 3481.2 4125.0 4240.8 4261.9 4267.6 3433.9 3471.1 3540.7 3552.8 3633.1 1066.8 1078.1 1096.8 1102.2 1104.8 647.3 832.4 844.6 847.7 878.3 4840.3 5023.7 5035.7 5059.6 5144.4 399.3 403.7 407.5 425.8 436.7 3520.2 3548.6 3561.4 3587.5 3603.4 9182.8 9452.4 9551.1 9570.9 9587.3 9170.7 9390.3 9428.4 9441.5 9513.1 7217.0 7294.1 7324.6 7353.5 7355.4 4913.7 5013.4 5092.4 5156.1 5229.3 8780.4 8828.2 8912.9 8914.8 8962.4 8658.6 8921.3 8957.7 9003.3 9051.9 6262.7 6307.0 6350.9 6383.7 6424.6 7070.1 7110.3 7111.9 7126.9 7138.1 6217.1 6271.3 6318.0 6490.3 6534.2 6631.5 6639.7 6705.5 6719.0 6775.1 6282.3 6295.5 6388.9 6413.5 6418.9 4225.3 4256.8 4357.8 4396.2 4416.4 4220.3 4351.5 4388.1 4415.7 4489.7 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#4] prototype.html Cycles:180 Average:4378.18 Median:4929.75 stddev:1288.62 (26.1%) stddev-sans-first:1255.50 18:35:11 INFO - PROCESS | 22366 | Values: 308.1 308.5 309.1 309.8 315.0 4888.1 4934.3 4949.9 4980.5 5017.8 4876.4 4902.3 4902.7 4925.2 4965.7 3620.9 3737.4 3895.8 3898.8 3921.0 3897.4 3900.9 3903.1 3908.8 3913.2 3864.6 3890.4 3892.2 3900.7 3901.5 3788.8 3867.5 3869.6 3899.2 3901.8 3416.7 3417.1 3421.4 3443.0 3450.1 4709.5 4730.2 4730.7 4740.4 4751.1 4412.3 4432.3 4443.0 4446.4 4461.6 4865.9 5183.3 5205.0 5206.9 5224.8 3662.4 3672.5 3676.9 3685.2 3685.8 5387.1 5397.8 5452.7 5463.9 5467.0 3626.5 3696.9 3697.6 3708.4 3714.9 3743.2 3762.0 3777.1 3779.6 3784.8 4311.7 4348.1 4355.9 4356.9 4363.3 4992.4 5171.8 5181.7 5184.6 5194.9 1376.1 1376.2 1377.8 1385.7 1391.3 853.7 901.9 922.9 938.0 939.2 4460.8 4590.2 4595.0 4605.4 4606.9 5378.9 5381.6 5381.7 5402.6 5433.2 4439.4 4477.3 4562.0 4589.7 4614.9 3028.9 3042.3 3056.6 3059.9 3060.3 5333.2 5338.4 5365.6 5367.9 5377.1 5600.4 5809.7 5830.7 5886.1 5886.7 5337.7 5341.7 5358.6 5367.2 5371.3 5704.6 5740.7 5746.7 5772.6 5773.9 5427.8 5649.7 5662.7 5666.0 5672.5 5351.6 5375.0 5377.1 5392.5 5412.2 3860.3 3886.8 3896.8 3900.7 3911.2 5097.4 5374.6 5379.1 5394.7 5397.1 5237.0 5245.8 5246.4 5256.4 5256.7 5084.0 5114.3 5147.2 5209.7 5219.2 5132.6 5146.2 5163.9 5178.3 5179.4 4972.7 5087.4 5219.0 5244.2 5261.4 5080.5 5100.6 5120.4 5126.8 5152.6 18:35:11 INFO - PROCESS | 22366 | 18:35:11 INFO - PROCESS | 22366 | [#5] yui.html Cycles:180 Average:12773.30 Median:54528.86 stddev:14877.67 (27.3%) stddev-sans-first:14891.42 18:35:11 INFO - PROCESS | 22366 | Values: 622.9 635.3 687.3 695.1 748.8 12030.2 12158.7 12177.4 12219.8 12248.5 11854.5 11870.3 12008.0 12075.5 12083.2 652.5 780.7 812.7 822.5 826.8 821.8 829.3 829.4 831.1 832.0 863.7 865.5 865.9 868.7 869.8 850.9 857.3 859.7 860.5 862.6 626.2 627.9 628.0 630.5 631.9 12259.4 12312.8 12380.7 12391.2 12394.1 12972.2 13035.5 13091.1 13337.5 13600.5 10366.8 10375.6 10404.8 10560.7 10616.6 3338.4 3363.8 3373.3 3389.4 3396.0 45412.8 45500.8 45627.3 45657.5 46853.0 9727.4 9749.6 9873.2 9911.9 9949.0 17440.6 17450.8 17471.5 17509.6 17542.9 6769.3 6847.5 6860.3 6920.7 7030.8 3640.2 3750.6 3763.5 3792.0 3856.3 2684.3 2746.5 2769.4 2776.6 2780.6 505.7 509.3 513.9 515.1 519.6 515.9 645.1 662.7 663.1 663.8 7982.4 8127.6 8165.7 8270.9 8349.9 586.6 611.5 621.4 621.6 654.1 3663.4 3740.9 3796.5 3811.2 3821.5 54151.7 54507.7 54550.0 55078.4 55348.4 47730.5 48092.5 48304.0 48507.5 49127.0 42997.1 43277.1 43446.6 43902.8 44135.3 7547.8 7613.5 7681.9 7709.8 7719.2 29214.9 29479.6 30018.8 30941.2 30965.0 36550.5 39417.8 39921.8 40113.6 40580.0 9851.8 9948.3 9951.0 10001.4 10040.0 10588.2 10696.3 10712.7 10926.8 11241.6 9483.3 9529.8 9567.5 9705.3 9889.7 9380.2 9514.8 9717.0 9816.8 10403.1 9154.3 9479.7 9522.3 9605.3 9788.6 8755.2 8824.7 8911.4 8915.7 8950.0 9059.0 9096.5 9130.5 9153.9 9160.0 18:35:11 INFO - PROCESS | 22366 | -------- Summary: end -------- 18:35:11 INFO - PROCESS | 22366 | 18:35:12 INFO - TEST-INFO | 22366: exit 0 18:35:12 INFO - TEST-OK | dromaeo_css | took 1114487ms 18:35:12 INFO - TEST-START | kraken 18:35:12 INFO - operating with platform_type : linux_ 18:35:12 INFO - Initialising browser for kraken test... 18:35:12 INFO - TEST-INFO | started process 22601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsgzxf1/profile http://localhost:57410/getInfo.html) 18:35:16 INFO - PROCESS | 22601 | 18:35:16 INFO - PROCESS | 22601 | (process:22669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:35:17 INFO - PROCESS | 22601 | __metrics Screen width/height:1600/1200 18:35:17 INFO - PROCESS | 22601 | colorDepth:24 18:35:17 INFO - PROCESS | 22601 | Browser inner width/height: 1024/697 18:35:17 INFO - PROCESS | 22601 | __metrics 18:35:17 ERROR - PROCESS | 22601 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:35:18 INFO - TEST-INFO | 22601: exit 0 18:35:18 INFO - Browser initialized. 18:35:18 INFO - Running cycle 1/1 for kraken test... 18:35:18 INFO - TEST-INFO | started process 22720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsgzxf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:35:20 INFO - PROCESS | 22720 | 18:35:20 INFO - PROCESS | 22720 | (process:22779): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:35:30 INFO - PROCESS | 22720 | RSS: Main: 166391808 18:35:30 INFO - PROCESS | 22720 | 18:35:33 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57410/tests/kraken/driver.html?testName=audio-beat-detection) 18:35:34 INFO - PROCESS | 22720 | RSS: Main: 170938368 18:35:34 INFO - PROCESS | 22720 | 18:35:37 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57410/tests/kraken/driver.html?testName=audio-dft) 18:35:37 INFO - PROCESS | 22720 | RSS: Main: 174579712 18:35:37 INFO - PROCESS | 22720 | 18:35:40 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57410/tests/kraken/driver.html?testName=audio-fft) 18:35:41 INFO - PROCESS | 22720 | RSS: Main: 164687872 18:35:41 INFO - PROCESS | 22720 | 18:35:43 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57410/tests/kraken/driver.html?testName=audio-oscillator) 18:35:43 INFO - PROCESS | 22720 | RSS: Main: 165294080 18:35:43 INFO - PROCESS | 22720 | 18:35:46 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:35:46 INFO - PROCESS | 22720 | RSS: Main: 166477824 18:35:46 INFO - PROCESS | 22720 | 18:35:50 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57410/tests/kraken/driver.html?testName=imaging-darkroom) 18:35:50 INFO - PROCESS | 22720 | RSS: Main: 166699008 18:35:50 INFO - PROCESS | 22720 | 18:35:54 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57410/tests/kraken/driver.html?testName=imaging-desaturate) 18:35:54 INFO - PROCESS | 22720 | RSS: Main: 166420480 18:35:54 INFO - PROCESS | 22720 | 18:35:57 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57410/tests/kraken/driver.html?testName=json-parse-financial) 18:35:58 INFO - PROCESS | 22720 | RSS: Main: 166838272 18:35:58 INFO - PROCESS | 22720 | 18:36:00 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:36:00 INFO - PROCESS | 22720 | RSS: Main: 167010304 18:36:00 INFO - PROCESS | 22720 | 18:36:02 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:36:03 INFO - PROCESS | 22720 | RSS: Main: 167137280 18:36:03 INFO - PROCESS | 22720 | 18:36:05 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:06 INFO - PROCESS | 22720 | RSS: Main: 167473152 18:36:06 INFO - PROCESS | 22720 | 18:36:08 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:09 INFO - PROCESS | 22720 | RSS: Main: 167669760 18:36:09 INFO - PROCESS | 22720 | 18:36:12 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:13 INFO - PROCESS | 22720 | RSS: Main: 167219200 18:36:13 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | Cycle 1(1): loaded http://localhost:57410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57410/tests/kraken/driver.html?testName=ai-astar) 18:36:15 INFO - PROCESS | 22720 | RSS: Main: 169095168 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | __start_tp_report 18:36:15 INFO - PROCESS | 22720 | _x_x_mozilla_page_load 18:36:15 INFO - PROCESS | 22720 | _x_x_mozilla_page_load_details 18:36:15 INFO - PROCESS | 22720 | |i|pagename|runs| 18:36:15 INFO - PROCESS | 22720 | |0;ai-astar;115;110;114;114;114;131;113;114;114;114 18:36:15 INFO - PROCESS | 22720 | |1;audio-beat-detection;167;132;159;183;141;162;168;141;200;134 18:36:15 INFO - PROCESS | 22720 | |2;audio-dft;163;164;165;176;164;164;162;163;166;161 18:36:15 INFO - PROCESS | 22720 | |3;audio-fft;74;74;78;184;79;74;74;77;155;78 18:36:15 INFO - PROCESS | 22720 | |4;audio-oscillator;95;95;145;95;95;94;142;94;93;144 18:36:15 INFO - PROCESS | 22720 | |5;imaging-gaussian-blur;118;119;118;118;117;117;118;117;117;118 18:36:15 INFO - PROCESS | 22720 | |6;imaging-darkroom;146;147;147;147;147;148;146;147;147;146 18:36:15 INFO - PROCESS | 22720 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 18:36:15 INFO - PROCESS | 22720 | |8;json-parse-financial;69;69;69;70;71;69;69;95;66;66 18:36:15 INFO - PROCESS | 22720 | |9;json-stringify-tinderbox;64;65;65;65;67;65;65;64;70;64 18:36:15 INFO - PROCESS | 22720 | |10;stanford-crypto-aes;80;80;82;80;80;81;81;80;82;80 18:36:15 INFO - PROCESS | 22720 | |11;stanford-crypto-ccm;133;129;132;140;133;133;144;136;167;135 18:36:15 INFO - PROCESS | 22720 | |12;stanford-crypto-pbkdf2;188;179;185;180;183;178;180;181;179;179 18:36:15 INFO - PROCESS | 22720 | |13;stanford-crypto-sha256-iterative;79;74;83;73;75;77;80;73;74;75 18:36:15 INFO - PROCESS | 22720 | __end_tp_report 18:36:15 INFO - PROCESS | 22720 | __start_cc_report 18:36:15 INFO - PROCESS | 22720 | _x_x_mozilla_cycle_collect,924 18:36:15 INFO - PROCESS | 22720 | __end_cc_report 18:36:15 INFO - PROCESS | 22720 | __startTimestamp1461634575304__endTimestamp 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | ------- Summary: start ------- 18:36:15 INFO - PROCESS | 22720 | Number of tests: 14 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:5.68 (5.0%) stddev-sans-first:6.02 18:36:15 INFO - PROCESS | 22720 | Values: 115.0 110.0 114.0 114.0 114.0 131.0 113.0 114.0 114.0 114.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#1] audio-beat-detection Cycles:10 Average:158.70 Median:164.50 stddev:22.14 (13.5%) stddev-sans-first:23.28 18:36:15 INFO - PROCESS | 22720 | Values: 167.0 132.0 159.0 183.0 141.0 162.0 168.0 141.0 200.0 134.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.18 (2.6%) stddev-sans-first:4.39 18:36:15 INFO - PROCESS | 22720 | Values: 163.0 164.0 165.0 176.0 164.0 164.0 162.0 163.0 166.0 161.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.06 (53.1%) stddev-sans-first:41.78 18:36:15 INFO - PROCESS | 22720 | Values: 74.0 74.0 78.0 184.0 79.0 74.0 74.0 77.0 155.0 78.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.50 stddev:23.80 (25.2%) stddev-sans-first:24.69 18:36:15 INFO - PROCESS | 22720 | Values: 95.0 95.0 145.0 95.0 95.0 94.0 142.0 94.0 93.0 144.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:36:15 INFO - PROCESS | 22720 | Values: 118.0 119.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 18:36:15 INFO - PROCESS | 22720 | Values: 146.0 147.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:36:15 INFO - PROCESS | 22720 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#8] json-parse-financial Cycles:10 Average:71.30 Median:69.00 stddev:8.47 (12.3%) stddev-sans-first:8.95 18:36:15 INFO - PROCESS | 22720 | Values: 69.0 69.0 69.0 70.0 71.0 69.0 69.0 95.0 66.0 66.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.84 (2.8%) stddev-sans-first:1.88 18:36:15 INFO - PROCESS | 22720 | Values: 64.0 65.0 65.0 65.0 67.0 65.0 65.0 64.0 70.0 64.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 18:36:15 INFO - PROCESS | 22720 | Values: 80.0 80.0 82.0 80.0 80.0 81.0 81.0 80.0 82.0 80.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.50 stddev:10.98 (8.1%) stddev-sans-first:11.49 18:36:15 INFO - PROCESS | 22720 | Values: 133.0 129.0 132.0 140.0 133.0 133.0 144.0 136.0 167.0 135.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:180.50 stddev:3.19 (1.8%) stddev-sans-first:2.24 18:36:15 INFO - PROCESS | 22720 | Values: 188.0 179.0 185.0 180.0 183.0 178.0 180.0 181.0 179.0 179.0 18:36:15 INFO - PROCESS | 22720 | 18:36:15 INFO - PROCESS | 22720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:76.00 stddev:3.37 (4.4%) stddev-sans-first:3.43 18:36:15 INFO - PROCESS | 22720 | Values: 79.0 74.0 83.0 73.0 75.0 77.0 80.0 73.0 74.0 75.0 18:36:15 INFO - PROCESS | 22720 | -------- Summary: end -------- 18:36:15 INFO - PROCESS | 22720 | 18:36:16 INFO - TEST-INFO | 22720: exit 0 18:36:16 INFO - TEST-OK | kraken | took 63916ms 18:36:16 INFO - SUITE-END | took 1178s 18:36:16 INFO - Completed test suite (00:19:38) 18:36:16 INFO - javascript benchmark 18:36:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.98713006435, 2655.389260470092, 2659.0693257359926, 2661.36127329441, 2686.328417895525, 4696.953030469695, 4698.060387922416, 4723.976380118099, 4742.7865746041425, 4774.474807771151, 4570.154521413541, 4686.695364801286, 4696.671233013691, 4731.479537250908, 4785.138675038492, 4343.066240758244, 4414.073044660625, 4425.291953287475, 4431.335299705038, 4431.756253406062, 619.0776498186392, 4209.074003719177, 4274.380214868842, 4316.913661726763, 4325.243082460573, 4276.273033584267, 4284.592963668447, 4295.806688699016, 4300.35494675798, 4308.4399028126145, 4245.8513952011845, 4256.170046840867, 4265.360195970629, 4280.807363668642, 4284.464441944757, 4226.429432026698, 4291.0, 4333.046729719456, 4377.956220437787, 4400.031992961543, 4585.426821647294, 4607.308903664477, 4615.699979501322, 4620.214563524175, 4678.508756580578, 4984.800607975677, 5022.271770593244, 5029.396472423333, 5035.269885866565, 5073.974630126862, 4923.040007198598, 5058.165402708549, 5104.438511763703, 5147.613928955306, 5154.484551544853, 4713.1280713067845, 4719.669623126382, 4732.763361831963, 4744.59670927975, 4766.76166191689, 5009.774560144802, 5140.948590514122, 5146.0, 5168.457311982263, 5191.039657663269, 4900.215965445512, 4918.139325618003, 4960.131976904027, 5007.273945277914, 5027.120253955616, 5058.9494105058475, 5060.671056381397, 5065.56942659878, 5070.7464626768515, 5113.616478764107, 4783.521647835259, 4985.351904252424, 4994.300797888299, 4996.6502344836235, 4998.650094493423, 4917.0, 4938.851834444972, 4995.800167993312, 4999.775010124553, 5039.823606173766, 4211.7262377945335, 4256.659467242614, 4261.509926358509, 4286.935695964563, 4294.463192100988, 3602.0994751312173, 3723.5345581802276, 3734.645208705223, 3742.139307959185, 3774.358359078963, 4170.395292682605, 4303.462067241595, 4337.82648694055, 4401.603855653007, 4441.911161776747, 4971.801127954841, 4976.527229913152, 4982.6512144149565, 4997.775100120503, 5027.648064635514, 4247.617714405718, 4298.226319262562, 4298.742075475481, 4311.943573824433, 4338.327559228324, 4479.17135329965, 4516.23224051912, 4532.410786597788, 4540.477845047796, 4561.110583436198, 4723.834665786681, 4761.976190119166, 4767.785449654774, 4775.498572649822, 4778.402699662543, 4813.326134341125, 5068.315777370155, 5080.136376815876, 5083.745812709423, 5112.105381558138, 4769.2130798417875, 4772.0, 4808.374911261653, 4838.443578988461, 4845.345878306524, 5036.269740887624, 5057.089723849743, 5065.8733531662, 5066.645334826527, 5113.258577506315, 4930.630202734881, 4948.430930443045, 5080.085584594808, 5139.280500729976, 5183.222516622537, 4919.458859525521, 4929.383827021622, 4931.9753401232765, 4935.259711043373, 4978.5519303261435, 4884.65807393479, 4902.92645610309, 4916.410030796327, 4925.975370123269, 4968.503149685002, 4669.836555720533, 4734.17151998392, 4840.854774356775, 4844.781984810763, 4905.852824415273, 4894.902101958012, 4902.093112774148, 4909.607231421549, 4916.213405855189, 4955.578775803953, 4783.234682450791, 4804.711717296974, 4805.231163013901, 4811.446683631287, 4864.440589332272], "value": 4592.290505651378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7164289498145, 607.7508221629132, 625.2278436131377, 626.8464226264563, 630.1335663462738, 27695.861520692393, 35604.64395356046, 36002.819985900096, 36137.27725445489, 36260.81869590651, 37982.0, 38678.4198237026, 38699.61300387002, 38713.22573548527, 38757.612423875755, 7671.424643151758, 7808.60956952153, 7829.451938364316, 7852.411069169807, 7862.724804631839, 7600.467967242295, 7732.845343093135, 7755.1469338372735, 7796.1814009529035, 7938.880916786224, 7923.524588524707, 7947.7218297359605, 7971.800704982364, 8003.67985280591, 8007.67969281228, 7957.5225486471, 7993.040835099767, 7997.560134192617, 8006.479578827358, 8012.359011279113, 7881.211878812131, 7939.245771651684, 7957.283844454027, 7988.640511176953, 8021.318187954031, 38060.429093563616, 38217.0445738856, 38243.043923901845, 38632.80683596564, 38679.22641547153, 3169.4770362890094, 3187.378461200067, 3239.5140728890856, 3303.9174020649675, 3454.936586291068, 28319.858400707864, 29009.12972610825, 29186.854065729534, 29703.851480742673, 30722.0, 3259.559959405474, 3271.9509207361907, 3290.3090351026312, 3327.8835240766457, 3398.8640454381793, 236176.0, 236515.0, 237009.0, 237412.0, 237472.0, 30491.2377190572, 51351.486485135414, 51754.0, 52092.0, 52160.0, 31961.0, 31994.520082198786, 32048.679513205036, 32123.0, 32174.0, 12393.504259829506, 12641.115121941375, 12748.681282967815, 12758.55345062937, 12769.0, 10056.849147262797, 10183.083522483012, 10203.94898025505, 10236.0, 10252.948735256425, 8080.39397045224, 8145.714899978472, 8190.54951977635, 8244.051934027664, 8303.086660467343, 3214.7106760391675, 3289.227031647561, 3292.226326813197, 3294.6870047345465, 3323.5845519310087, 907.9092090790868, 927.9953600231955, 929.4516235421135, 992.3847214726916, 1068.1828401273033, 28780.424391512053, 28969.275768105545, 29101.0, 29151.0, 29312.413751724845, 891.6210610490516, 947.8009617980301, 960.8894977077586, 970.427447805798, 1076.1767248055244, 13419.0, 13920.930395347958, 14171.716565668628, 14175.078619889675, 14330.928345358207, 344160.0, 351028.0, 352300.0, 353476.0, 353478.0, 49443.50556494461, 50156.0, 50219.0, 50586.494135058914, 50630.24054639183, 1193.4689063366718, 1216.8260712083154, 1226.9509219631116, 1270.0474644016988, 1270.8602053774262, 25262.368440789127, 27170.0, 27411.31471713223, 27552.173434796987, 27762.444751105268, 41294.1741165169, 41520.1695966085, 41561.1687766249, 41571.58428415798, 41663.37504937368, 292017.0, 294157.0, 294536.0, 296897.0, 298613.0, 25278.115265965604, 25471.36321591975, 25628.74371256338, 25742.0, 25745.227643170736, 41724.24481796653, 41904.58095419007, 42388.152236955706, 42872.571274286856, 43073.353899690905, 36517.81741091277, 36543.45184822283, 36939.44590831194, 37129.0, 37648.43527347147, 35841.0, 36572.63427365692, 36636.26727465489, 36673.44989825208, 36869.63130368662, 34929.30141397208, 35083.473747893295, 35519.64480355267, 35890.46164307485, 35895.923122306376, 32236.677633223368, 33044.339113218084, 33913.96516209035, 34137.0, 34139.48790768091, 25595.488090238465, 25639.615405768556, 25719.614205786555, 25851.61222581625, 25925.0], "value": 16336.627571818086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.2301627695777, 381.68892352732524, 383.67579395410866, 395.800120938926, 401.861357831548, 15512.534623961285, 16658.750118748227, 17237.310507579696, 17249.827501724994, 17260.654786904255, 16742.83257167428, 16904.323827046934, 17369.652606947853, 17410.129493525335, 17452.214650340735, 5107.0, 5284.180951952453, 5293.655912365703, 5297.682139071649, 5330.440303768107, 3773.1510410157634, 5774.3936886626925, 6019.729112189962, 6048.637081775108, 6050.818475445722, 5134.332536770234, 5956.761729530814, 5990.760369585233, 5993.640381577119, 6022.036474164134, 5352.598555108343, 5362.865928351784, 5387.649802762808, 5402.513773760361, 5406.459354064582, 5077.162268225738, 5393.541548968343, 5394.379646340682, 5402.459754024605, 5425.267588875491, 12477.438515266835, 12666.683332916751, 12755.0, 18156.45530634083, 20913.477163070893, 1809.9366721937001, 1834.862385321093, 1836.8714190006706, 1874.3346112130134, 1950.3368854589366, 8641.179087986631, 9421.670241541582, 9426.811463770755, 9682.854757178577, 9729.708108756678, 1727.7062899307023, 1775.7336399540043, 1803.4769916724135, 1805.702059160237, 1835.1191428114446, 70015.0, 71434.0, 72435.63782181055, 74405.62797186033, 74790.25209747888, 10070.798584028278, 10182.694519164288, 10379.948100259451, 10446.0, 10471.0, 14519.346629401702, 14522.85477145215, 14523.128612283297, 14595.562133136023, 14610.123392596266, 7327.194008659043, 7562.0, 7626.313631773167, 7673.309402153722, 7679.923200767921, 7116.750913718099, 7196.172440169447, 7215.891761623579, 7237.565746055148, 7257.092863392076, 4326.848560300375, 4477.955220447819, 4494.191045611821, 4505.864824055284, 4553.908921821545, 1716.9399071032453, 1752.5969027123579, 1872.129459801199, 1877.3804644467293, 1914.2534411579495, 863.9136086391311, 945.9432434053979, 948.5020364308793, 951.8572214167792, 1001.1390204424189, 16332.0, 16492.17539123039, 16700.49898503047, 16866.578335541464, 16873.240704168344, 851.7104184577273, 860.4106187261746, 862.4782006885869, 876.0407353947545, 878.2315473960285, 9217.861732074025, 9520.23838092951, 9538.380005299634, 9663.71008869721, 9781.951090244504, 335047.0, 354821.0, 355941.0, 355993.0, 357646.0, 78052.60973695209, 78154.76902227972, 78932.21067789248, 79895.0, 80779.19220807716, 876.9698148785541, 878.7232021913205, 896.5606852642159, 903.9683611073581, 905.1220316293185, 14962.551376926722, 15086.773698394314, 15114.773278401053, 15150.621234469227, 15163.0, 34354.0, 35549.64450355567, 35595.0, 36048.81975590105, 36918.0, 46459.0, 49210.753946231474, 49997.50002499928, 50393.244101339245, 50575.49424505708, 7487.925120748941, 7581.583012934341, 7598.164201937672, 7736.381089512938, 7758.107817600822, 10378.42918639482, 11137.888621114009, 11168.441577921234, 11219.382933938712, 11414.828777568177, 9121.315901307296, 9835.16401105914, 9914.256430767866, 10087.646932357333, 10263.486825658836, 9680.322377433793, 9828.066333698573, 9964.551595178089, 10004.0, 10036.598536058476, 9732.951335243279, 9903.405795652285, 10034.498275086362, 10267.94866025665, 10346.844797328196, 7580.0, 7636.923630763621, 7642.541447513167, 7665.655045523076, 7752.108507521481, 9352.812943741223, 10078.092232718802, 10178.083972442515, 10231.0, 10321.896781032094], "value": 8172.012636142603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.5487471446493, 1451.0930668332292, 1576.8659663928565, 1723.35374234662, 1770.34399529238, 6392.169018027662, 7259.782206533812, 7352.485326027174, 7625.161232264447, 7649.0, 7281.963590182055, 7328.120625524931, 7379.040724705781, 7380.151282602503, 7386.482946193769, 2120.68189771534, 2160.91356345746, 2161.3083813179787, 2161.3623980925586, 2171.381156370435, 2059.320424259998, 2093.9581208375826, 2116.3650904728597, 2137.9893100534478, 2146.8604540704805, 2130.3502431758307, 2134.8185404240658, 2142.78572142786, 2154.2029449103775, 2168.739751229855, 2083.6561967275456, 2085.9061342239634, 2086.9165233390722, 2088.2064815370213, 2091.832653387733, 2085.666293393065, 2154.9461263468384, 2155.0302363936294, 2163.177992362892, 2174.1629472652985, 7346.081739782528, 7459.328660420588, 7467.514611550286, 7517.323440890292, 7526.623668816537, 4310.202612516695, 4386.758728269944, 4395.934060989088, 4423.402840616508, 4423.800928958204, 2634.578467445219, 2680.5175068487665, 2778.4304217635336, 2793.2318612381555, 2813.8452385118812, 910.5811326789685, 915.56053094515, 916.9220616247627, 919.4988731141544, 928.3223247029639, 9538.380005299634, 9719.757006074835, 9730.172935300508, 9799.363041402286, 9799.363041402357, 4108.383742438598, 4139.8965025874595, 4157.958420415817, 4192.329227323614, 4304.956950430518, 8147.714829980922, 8168.7957801055445, 8209.630566624517, 8213.425060245725, 8231.300339471092, 4557.840475583339, 4560.931586026212, 4567.223571992769, 4584.037352156018, 4587.3348364486965, 3481.199324155408, 4125.030617804873, 4240.787960601958, 4261.850835220753, 4267.551907049778, 3433.896983090511, 3471.062813040465, 3540.6636369544854, 3552.8045957472586, 3633.109888077438, 1066.7599790047332, 1078.0890147825075, 1096.8245080787035, 1102.1568500097433, 1104.8011357955484, 647.2976820150095, 832.4297855968681, 844.5523872347666, 847.656699036891, 878.2885862451435, 4840.273958906122, 5023.723695196799, 5035.748212589356, 5059.62052846038, 5144.356955380577, 399.3351070467639, 403.73958796576045, 407.4804624104291, 425.8275398463627, 436.6506794564336, 3520.190356218084, 3548.6451354864307, 3561.4479755637917, 3587.529113063684, 3603.4414665726854, 9182.77043073915, 9452.43285402878, 9551.14039736427, 9570.856437153448, 9587.280953928483, 9170.67902623405, 9390.295727820441, 9428.434293942386, 9441.527923603793, 9513.096255855682, 7217.0, 7294.088238970129, 7324.597147156957, 7353.485256032133, 7355.448341374418, 4913.680610760289, 5013.448520662651, 5092.388913330424, 5156.097682905552, 5229.267902493578, 8780.385373023826, 8828.205461508238, 8912.86630700527, 8914.821703566022, 8962.372633915564, 8658.614621660505, 8921.286297096087, 8957.686480973134, 9003.279737621106, 9051.864222036544, 6262.655553944394, 6306.9684651576445, 6350.872982540231, 6383.691343274711, 6424.582402143846, 7070.080889484334, 7110.32451917067, 7111.928880711127, 7126.928730712627, 7138.072050633385, 6217.09852071438, 6271.3415091414745, 6318.0, 6490.253620833664, 6534.248561415498, 6631.502637302126, 6639.7012134455035, 6705.497087718343, 6719.0, 6775.051492791112, 6282.277538082996, 6295.476429188393, 6388.9041664374145, 6413.518986075969, 6418.871622567429, 4225.302825033835, 4256.829726810893, 4357.8038988246235, 4396.208682437192, 4416.425864637705, 4220.303649897733, 4351.521332653469, 4388.05656783793, 4415.6909016368545, 4489.73061616304], "value": 3936.896513772227, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.1003469867985, 308.5341134886322, 309.1421305876195, 309.77231734674996, 315.04227149465623, 4888.144574699427, 4934.309196712463, 4949.851504454868, 4980.501949805027, 5017.849464516061, 4876.414830220369, 4902.289168070628, 4902.705837649743, 4925.18734408823, 4965.652404331699, 3620.9275814483763, 3737.439384092381, 3895.7662540247534, 3898.8050597470155, 3921.0, 3897.4348719435807, 3900.882973510785, 3903.1217975955465, 3908.8241029153614, 3913.1782325711633, 3864.574896761354, 3890.396988466792, 3892.2215556888596, 3900.746451480659, 3901.51231096113, 3788.7916164610933, 3867.5165604299464, 3869.5936926622862, 3899.200663863901, 3901.804909754501, 3416.692497675196, 3417.094469965461, 3421.367047096295, 3442.9655703442895, 3450.068481509978, 4709.458412282563, 4730.243161094243, 4730.716157030589, 4740.431148262231, 4751.14479393709, 4412.3160910059, 4432.268675668511, 4443.0, 4446.355278484634, 4461.620762235214, 4865.902681946377, 5183.3002544656365, 5204.959008198375, 5206.895862082775, 5224.817131400383, 3662.359087159736, 3672.540932383452, 3676.8713095041544, 3685.2261025184744, 3685.7788532688123, 5387.138057910715, 5397.811076612339, 5452.727363631802, 5463.945360546383, 5467.043267428224, 3626.546681664792, 3696.9075773105887, 3697.574778900407, 3708.4437334399518, 3714.88855334335, 3743.2139250757646, 3761.962380376216, 3777.0934975606206, 3779.603141670085, 3784.7918364489665, 4311.741295522216, 4348.108637729321, 4355.869323920288, 4356.934645980313, 4363.345498175299, 4992.425871024806, 5171.7672704728375, 5181.715005674724, 5184.585233181337, 5194.92207616886, 1376.078027721429, 1376.2361889151616, 1377.7520046391746, 1385.6951470676436, 1391.2834890031643, 853.7353420439683, 901.8647202919483, 922.8615707643772, 937.9812403752023, 939.2016785732073, 4460.754658493749, 4590.1737687215955, 4594.977025114853, 4605.378273933044, 4606.89434535709, 5378.865528361822, 5381.623286369995, 5381.704006279692, 5402.594805389612, 5433.1850222466155, 4439.445069366329, 4477.32840073985, 4562.0191658792855, 4589.678722489461, 4614.861554153381, 3028.8939887103847, 3042.300270937697, 3056.5720799088144, 3059.8929037484027, 3060.32672811981, 5333.200019996954, 5338.412774594792, 5365.570754339644, 5367.919481207785, 5377.085895397791, 5600.411956744565, 5809.7095145242565, 5830.7084645767545, 5886.087656413263, 5886.705664716747, 5337.6797392156595, 5341.679499229981, 5358.624896257303, 5367.168088946298, 5371.274877891435, 5704.572157088152, 5740.655560666373, 5746.655200687972, 5772.567057470623, 5773.913391299218, 5427.782888684566, 5649.745761440828, 5662.688552129508, 5665.971670141623, 5672.517835983987, 5351.59863010268, 5374.984380857179, 5377.059014672339, 5392.514673679388, 5412.215228791882, 3860.285847118292, 3886.7667939923695, 3896.7856767876906, 3900.6684431822478, 3911.2373087247715, 5097.439281678938, 5374.596905232045, 5379.085555455504, 5394.676319420847, 5397.136458166675, 5236.9738151309, 5245.790168393374, 5246.42289348179, 5256.369235691742, 5256.685828542864, 5083.975034854256, 5114.258432527337, 5147.176451767849, 5209.661372010807, 5219.217117432416, 5132.640715149903, 5146.150885103916, 5163.870903227449, 5178.326817513699, 5179.430262671028, 4972.65191436596, 5087.389513258285, 5219.0, 5244.164542410126, 5261.421243663271, 5080.517350851663, 5100.6429549931145, 5120.436751957207, 5126.769295381642, 5152.639315247897], "value": 3972.9904097238064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.8816524860276, 635.2662674610823, 687.2543290529775, 695.0963747128732, 748.8464864702737, 12030.157888947777, 12158.69603259919, 12177.391130443486, 12219.755604887909, 12248.510059597616, 11854.525818967231, 11870.347130907818, 12008.039356851452, 12075.516979320839, 12083.214591051597, 652.4682383857165, 780.6604127204656, 812.7480481050878, 822.5270469480043, 826.8387664405413, 821.8191997760513, 829.3365307753803, 829.3862541719114, 831.1480732249432, 832.026528961114, 863.7020228021322, 865.4590880699562, 865.8787769712245, 868.68727258187, 869.7955980344614, 850.9489430634181, 857.34413173922, 859.716293623106, 860.5181098584782, 862.5644049754897, 626.1515646299245, 627.8932581461163, 627.9623222606658, 630.4515071887441, 631.902055181443, 12259.387030648431, 12312.81530777039, 12380.690482738004, 12391.194572352768, 12394.070444716592, 12972.221666700028, 13035.478580856849, 13091.149075310075, 13337.533186338529, 13600.523981660594, 10366.792664146751, 10375.584976600927, 10404.843927341097, 10560.683179504627, 10616.57533698651, 3338.3990881641294, 3363.8486268117995, 3373.2747459296124, 3389.440742277521, 3396.0, 45412.77293613511, 45500.77249613731, 45627.315590266175, 45657.54342456566, 46853.0, 9727.416355018722, 9749.561269742879, 9873.210143188528, 9911.851322230172, 9948.950255248677, 17440.5639859002, 17450.825491745174, 17471.475855724348, 17509.64980700379, 17542.912285438746, 6769.255381907986, 6847.520673552903, 6860.3139686031, 6920.688569014406, 7030.824229394306, 3640.162762564625, 3750.643688849555, 3763.49192858966, 3792.0, 3856.3444214483607, 2684.2752456836934, 2746.491898998692, 2769.418422131335, 2776.583512473145, 2780.6107144999714, 505.6738403729647, 509.31242822189745, 513.8715321169708, 515.1165750737504, 519.6284656470642, 515.8581390117672, 645.1258544671902, 662.6587307536622, 663.0650782396893, 663.8108139180407, 7982.401319901031, 8127.634256458474, 8165.673373065129, 8270.875936860952, 8349.916500835036, 586.5952492780053, 611.4649681528663, 621.4158690830604, 621.5773274173605, 654.0646874968841, 3663.358912190356, 3740.8690695825517, 3796.487474191004, 3811.1615444602144, 3821.541415030214, 54151.72924135354, 54507.72746136323, 54550.0, 55078.44921550733, 55348.446515535135, 47730.5226947733, 48092.519074809505, 48304.03391932142, 48507.5149248503, 49127.0, 42997.14005719868, 43277.134457310676, 43446.56553434425, 43902.780486098, 44135.33796992983, 7547.849043019219, 7613.505122167041, 7681.884771728541, 7709.768706938801, 7719.228077192236, 29214.853925730236, 29479.55780663249, 30018.849905750332, 30941.226469338446, 30965.0, 36550.4517432244, 39417.802910985265, 39921.80039099786, 40113.598864010986, 40580.0, 9851.802963940538, 9948.343604778727, 9950.950245248727, 10001.399916005063, 10040.0, 10588.152947764007, 10696.304740192174, 10712.73218169552, 10926.836097458703, 11241.60654377093, 9483.28875334339, 9529.761755956157, 9567.521623918916, 9705.272104592324, 9889.653862114792, 9380.167957052325, 9514.809703806024, 9717.0, 9816.754581135528, 10403.063724264852, 9154.26765858743, 9479.668211612561, 9522.285828563025, 9605.279604029585, 9788.608455661979, 8755.168259015383, 8824.691135810215, 8911.37620366568, 8915.73252802417, 8950.0, 9059.0, 9096.54517274147, 9130.452172869649, 9153.86269205949, 9159.954200228956], "value": 5877.126734340751, "unit": "score"}], "name": "dromaeo_css", "value": 6192.044335582055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 114.0, 114.0, 114.0, 131.0, 113.0, 114.0, 114.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 132.0, 159.0, 183.0, 141.0, 162.0, 168.0, 141.0, 200.0, 134.0], "value": 158.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 176.0, 164.0, 164.0, 162.0, 163.0, 166.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 184.0, 79.0, 74.0, 74.0, 77.0, 155.0, 78.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 145.0, 95.0, 95.0, 94.0, 142.0, 94.0, 93.0, 144.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 71.0, 69.0, 69.0, 95.0, 66.0, 66.0], "value": 71.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 64.0, 70.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 80.0, 80.0, 81.0, 81.0, 80.0, 82.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 132.0, 140.0, 133.0, 133.0, 144.0, 136.0, 167.0, 135.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 179.0, 185.0, 180.0, 183.0, 178.0, 180.0, 181.0, 179.0, 179.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 83.0, 73.0, 75.0, 77.0, 80.0, 73.0, 74.0, 75.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1615.4, "alertThreshold": 2.0}]} 18:36:16 INFO - Return code: 0 18:36:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:36:16 ERROR - # TBPL SUCCESS # 18:36:16 INFO - Running post-action listener: _resource_record_post_action 18:36:16 INFO - Running post-run listener: _resource_record_post_run 18:36:17 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 519184384; Read time: 0; Write time: 412508 18:36:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234700800; Read time: 0; Write time: 254716 18:36:17 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 284483584; Read time: 0; Write time: 157792 18:36:17 INFO - Running post-run listener: _upload_blobber_files 18:36:17 INFO - Blob upload gear active. 18:36:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:36:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:36:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:18 INFO - (blobuploader) - INFO - Done attempting. 18:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:20 INFO - (blobuploader) - INFO - Done attempting. 18:36:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:36:20 INFO - Return code: 0 18:36:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:36:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:36:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b4b14393af8a1ed38265392bc2355d912c7efba18b8d5476e78b19c17e7a64768822a84200eb29ab9416bf08b497766a513d7c1d275b142eade14c7783256f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b60746f2a5b98d022b3d82707d424aee13a6ef2e6c32be6d9b3cd5335f1e17b2e1de113c407aa3cb9362b9a6806eca4f1317c412e2f5c804e25cf73c9fc7f1"} 18:36:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:36:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:36:20 INFO - Contents: 18:36:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b4b14393af8a1ed38265392bc2355d912c7efba18b8d5476e78b19c17e7a64768822a84200eb29ab9416bf08b497766a513d7c1d275b142eade14c7783256f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b60746f2a5b98d022b3d82707d424aee13a6ef2e6c32be6d9b3cd5335f1e17b2e1de113c407aa3cb9362b9a6806eca4f1317c412e2f5c804e25cf73c9fc7f1"} 18:36:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:36:20 INFO - Copying logs to upload dir... 18:36:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:36:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.179037 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 18:36:19.848369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 18:36:19.852743) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 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/8b4b14393af8a1ed38265392bc2355d912c7efba18b8d5476e78b19c17e7a64768822a84200eb29ab9416bf08b497766a513d7c1d275b142eade14c7783256f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b60746f2a5b98d022b3d82707d424aee13a6ef2e6c32be6d9b3cd5335f1e17b2e1de113c407aa3cb9362b9a6806eca4f1317c412e2f5c804e25cf73c9fc7f1"} build_url:https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/RGrZ9dVsSKaGWFzOYD0zMw/artifacts/public/build/firefox-49.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/8b4b14393af8a1ed38265392bc2355d912c7efba18b8d5476e78b19c17e7a64768822a84200eb29ab9416bf08b497766a513d7c1d275b142eade14c7783256f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2b60746f2a5b98d022b3d82707d424aee13a6ef2e6c32be6d9b3cd5335f1e17b2e1de113c407aa3cb9362b9a6806eca4f1317c412e2f5c804e25cf73c9fc7f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 18:36:19.884633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:36:19.885187) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461629749.855137-1980654584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:36:19.966244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 18:36:19.966596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 18:36:19.966914) ========= ========= Total master_lag: 0.29 =========