builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1461062205.02 results: success (0) buildid: 20160419025149 builduid: 5368043b0c0c49f09efeef07374319b6 revision: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.024826) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.025292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.025578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.041990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.042379) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 03:36:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-04-19 03:36:45 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.180875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.181245) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.231474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.231885) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 --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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 03:36:45,495 truncating revision to first 12 chars 2016-04-19 03:36:45,496 Setting DEBUG logging. 2016-04-19 03:36:45,496 attempt 1/10 2016-04-19 03:36:45,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f8f469a45c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 03:36:45,910 unpacking tar archive at: fx-team-6f8f469a45c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.928355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.928689) ========= script_repo_revision: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.929113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.929388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:36:45.939486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-19 03:36:45.939875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:46 INFO - MultiFileLogger online at 20160419 03:36:46 in /builds/slave/test 03:36:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:36:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:46 INFO - {'append_to_log': False, 03:36:46 INFO - 'base_work_dir': '/builds/slave/test', 03:36:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:36:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:46 INFO - 'branch': 'Fx-Team-Non-PGO', 03:36:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:46 INFO - 'config_files': ('talos/linux_config.py',), 03:36:46 INFO - 'default_actions': ('clobber', 03:36:46 INFO - 'read-buildbot-config', 03:36:46 INFO - 'download-and-extract', 03:36:46 INFO - 'populate-webroot', 03:36:46 INFO - 'create-virtualenv', 03:36:46 INFO - 'install', 03:36:46 INFO - 'run-tests'), 03:36:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:46 INFO - 'download_minidump_stackwalk': True, 03:36:46 INFO - 'download_symbols': 'ondemand', 03:36:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:46 INFO - 'installer_path': 'installer.exe', 03:36:46 INFO - 'log_level': 'info', 03:36:46 INFO - 'log_name': 'talos', 03:36:46 INFO - 'log_to_console': True, 03:36:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:46 INFO - 'opt_config_files': (), 03:36:46 INFO - 'pip_index': False, 03:36:46 INFO - 'sps_profile': False, 03:36:46 INFO - 'sps_profile_interval': 0, 03:36:46 INFO - 'suite': 'dromaeojs-e10s', 03:36:46 INFO - 'system_bits': '32', 03:36:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:46 INFO - 'title': 'talos-linux64-ix-001', 03:36:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:46 INFO - 'use_talos_json': True, 03:36:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:46 INFO - 'work_dir': 'build'} 03:36:46 INFO - ##### 03:36:46 INFO - ##### Running clobber step. 03:36:46 INFO - ##### 03:36:46 INFO - Running pre-action listener: _resource_record_pre_action 03:36:46 INFO - Running main action method: clobber 03:36:46 INFO - rmtree: /builds/slave/test/build 03:36:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:46 INFO - Running post-action listener: _resource_record_post_action 03:36:46 INFO - ##### 03:36:46 INFO - ##### Running read-buildbot-config step. 03:36:46 INFO - ##### 03:36:46 INFO - Running pre-action listener: _resource_record_pre_action 03:36:46 INFO - Running main action method: read_buildbot_config 03:36:46 INFO - Using buildbot properties: 03:36:46 INFO - { 03:36:46 INFO - "project": "", 03:36:46 INFO - "product": "firefox", 03:36:46 INFO - "script_repo_revision": "production", 03:36:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:36:46 INFO - "repository": "", 03:36:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:36:46 INFO - "buildid": "20160419025149", 03:36:46 INFO - "pgo_build": "False", 03:36:46 INFO - "basedir": "/builds/slave/test", 03:36:46 INFO - "buildnumber": 1417, 03:36:46 INFO - "slavename": "talos-linux64-ix-001", 03:36:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:46 INFO - "platform": "ubuntu64_hw", 03:36:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:36:46 INFO - "branch": "fx-team", 03:36:46 INFO - "repo_path": "integration/fx-team", 03:36:46 INFO - "revision": "6f8f469a45c08371398d2a98bb7fb7b2a5d07355", 03:36:46 INFO - "stage_platform": "linux64", 03:36:46 INFO - "builduid": "5368043b0c0c49f09efeef07374319b6", 03:36:46 INFO - "slavebuilddir": "test" 03:36:46 INFO - } 03:36:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:36:46 INFO - Running post-action listener: _resource_record_post_action 03:36:46 INFO - ##### 03:36:46 INFO - ##### Running download-and-extract step. 03:36:46 INFO - ##### 03:36:46 INFO - Running pre-action listener: _resource_record_pre_action 03:36:46 INFO - Running main action method: download_and_extract 03:36:46 INFO - mkdir: /builds/slave/test/build/tests 03:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:46 INFO - https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:36:47 INFO - Downloaded 1361 bytes. 03:36:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:36:47 INFO - Using the following test package requirements: 03:36:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:36:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:36:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'jsshell-linux-x86_64.zip'], 03:36:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:36:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:36:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:36:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:36:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:36:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:47 INFO - https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:48 INFO - Downloaded 22209599 bytes. 03:36:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:36:49 INFO - Return code: 0 03:36:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:49 INFO - https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:51 INFO - Downloaded 22209599 bytes. 03:36:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:36:52 INFO - Return code: 0 03:36: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')]} 03:36:52 INFO - https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:36:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:36:53 INFO - Downloaded 10845952 bytes. 03:36:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:36:53 INFO - Return code: 0 03:36: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')]} 03:36:53 INFO - https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:36:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:36:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:36:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:36:55 INFO - Downloaded 54453081 bytes. 03:36:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:36:55 INFO - mkdir: /builds/slave/test/properties 03:36:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:55 INFO - Contents: 03:36:55 INFO - build_url:https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:36:55 INFO - Running post-action listener: _resource_record_post_action 03:36:55 INFO - Running post-action listener: set_extra_try_arguments 03:36:55 INFO - ##### 03:36:55 INFO - ##### Running populate-webroot step. 03:36:55 INFO - ##### 03:36:55 INFO - Running pre-action listener: _resource_record_pre_action 03:36:55 INFO - Running main action method: populate_webroot 03:36:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:55 INFO - '--tppagecycles', 03:36:55 INFO - '7'], 03:36:55 INFO - 'tests': ['tsvgm']}}, 03:36:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['damp', 'tps']}, 03:36:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'tests': ['damp', 'tps']}, 03:36:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['dromaeo_dom']}, 03:36:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['a11yr', 03:36:55 INFO - 'ts_paint', 03:36:55 INFO - 'tpaint', 03:36:55 INFO - 'sessionrestore', 03:36:55 INFO - 'sessionrestore_no_auto_restore', 03:36:55 INFO - 'tabpaint']}, 03:36:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['tsvgx', 03:36:55 INFO - 'tsvgr_opacity', 03:36:55 INFO - 'tart', 03:36:55 INFO - 'tscrollx', 03:36:55 INFO - 'cart']}, 03:36:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:55 INFO - 'tsvgr_opacity', 03:36:55 INFO - 'tart', 03:36:55 INFO - 'tscrollx', 03:36:55 INFO - 'cart']}, 03:36:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'talos_options': ['--disable-e10s'], 03:36:55 INFO - 'tests': ['tp5o']}, 03:36:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'tests': ['tp5o']}, 03:36:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'talos_options': ['--disable-e10s', 03:36:55 INFO - '--xperf_path', 03:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:55 INFO - 'tests': ['tp5n']}, 03:36:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:55 INFO - 'talos_options': ['--xperf_path', 03:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:55 INFO - 'tests': ['tp5n']}}, 03:36:55 INFO - 'talos.zip': {'path': '', 03:36:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:55 INFO - Running post-action listener: _resource_record_post_action 03:36:55 INFO - ##### 03:36:55 INFO - ##### Running create-virtualenv step. 03:36:55 INFO - ##### 03:36:55 INFO - Running pre-action listener: _resource_record_pre_action 03:36:55 INFO - Running main action method: create_virtualenv 03:36:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:55 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 03:36:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:56 INFO - Using real prefix '/usr' 03:36:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:58 INFO - Installing pip.................done. 03:36:58 INFO - Return code: 0 03:36:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:58 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')]} 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 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')]} 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:36:58 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 03:36:58 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 03:36:58 INFO - Using env: {'DISPLAY': ':0', 03:36:58 INFO - 'HOME': '/home/cltbld', 03:36:58 INFO - 'LANG': 'en_US.UTF-8', 03:36:58 INFO - 'LANGUAGE': 'en_US:en', 03:36:58 INFO - 'LOGNAME': 'cltbld', 03:36:58 INFO - 'MAIL': '/var/mail/cltbld', 03:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:58 INFO - 'MOZ_NO_REMOTE': '1', 03:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:58 INFO - 'NO_EM_RESTART': '1', 03:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:58 INFO - 'PWD': '/builds/slave/test', 03:36:58 INFO - 'SHELL': '/bin/bash', 03:36:58 INFO - 'SHLVL': '1', 03:36:58 INFO - 'TERM': 'linux', 03:36:58 INFO - 'TMOUT': '86400', 03:36:58 INFO - 'USER': 'cltbld', 03:36:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:58 INFO - '_': '/tools/buildbot/bin/python'} 03:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:58 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 03:36:58 INFO - Cleaning up... 03:36:58 INFO - Return code: 0 03:36:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:36:58 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')]} 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 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')]} 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:36:58 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 03:36:58 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 03:36:58 INFO - Using env: {'DISPLAY': ':0', 03:36:58 INFO - 'HOME': '/home/cltbld', 03:36:58 INFO - 'LANG': 'en_US.UTF-8', 03:36:58 INFO - 'LANGUAGE': 'en_US:en', 03:36:58 INFO - 'LOGNAME': 'cltbld', 03:36:58 INFO - 'MAIL': '/var/mail/cltbld', 03:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:58 INFO - 'MOZ_NO_REMOTE': '1', 03:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:58 INFO - 'NO_EM_RESTART': '1', 03:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:58 INFO - 'PWD': '/builds/slave/test', 03:36:58 INFO - 'SHELL': '/bin/bash', 03:36:58 INFO - 'SHLVL': '1', 03:36:58 INFO - 'TERM': 'linux', 03:36:58 INFO - 'TMOUT': '86400', 03:36:58 INFO - 'USER': 'cltbld', 03:36:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:58 INFO - '_': '/tools/buildbot/bin/python'} 03:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:58 INFO - Downloading/unpacking psutil>=0.7.1 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:00 INFO - Installing collected packages: psutil 03:37:00 INFO - Running setup.py install for psutil 03:37:01 INFO - building 'psutil._psutil_linux' extension 03:37: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 03:37: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 03:37:01 INFO - building 'psutil._psutil_posix' extension 03:37: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 03:37: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:01 INFO - Successfully installed psutil 03:37:01 INFO - Cleaning up... 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:37:01 INFO - Using env: {'DISPLAY': ':0', 03:37:01 INFO - 'HOME': '/home/cltbld', 03:37:01 INFO - 'LANG': 'en_US.UTF-8', 03:37:01 INFO - 'LANGUAGE': 'en_US:en', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MAIL': '/var/mail/cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SHLVL': '1', 03:37:01 INFO - 'TERM': 'linux', 03:37:01 INFO - 'TMOUT': '86400', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - '_': '/tools/buildbot/bin/python'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:37:03 INFO - Installing collected packages: mozsystemmonitor 03:37:03 INFO - Running setup.py install for mozsystemmonitor 03:37:03 INFO - Successfully installed mozsystemmonitor 03:37:03 INFO - Cleaning up... 03:37:03 INFO - Return code: 0 03:37:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:03 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')]} 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 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')]} 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37:03 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 03:37:03 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 03:37:03 INFO - Using env: {'DISPLAY': ':0', 03:37:03 INFO - 'HOME': '/home/cltbld', 03:37:03 INFO - 'LANG': 'en_US.UTF-8', 03:37:03 INFO - 'LANGUAGE': 'en_US:en', 03:37:03 INFO - 'LOGNAME': 'cltbld', 03:37:03 INFO - 'MAIL': '/var/mail/cltbld', 03:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:03 INFO - 'MOZ_NO_REMOTE': '1', 03:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:03 INFO - 'NO_EM_RESTART': '1', 03:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:03 INFO - 'PWD': '/builds/slave/test', 03:37:03 INFO - 'SHELL': '/bin/bash', 03:37:03 INFO - 'SHLVL': '1', 03:37:03 INFO - 'TERM': 'linux', 03:37:03 INFO - 'TMOUT': '86400', 03:37:03 INFO - 'USER': 'cltbld', 03:37:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:03 INFO - '_': '/tools/buildbot/bin/python'} 03:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:05 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 03:37:05 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 03:37:05 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 03:37:05 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 03:37:05 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 03:37:05 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 03:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:06 INFO - Downloading docopt-0.6.1.tar.gz 03:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:06 INFO - Running setup.py install for blobuploader 03:37:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:06 INFO - Running setup.py install for requests 03:37:07 INFO - Running setup.py install for docopt 03:37:07 INFO - Successfully installed blobuploader requests docopt 03:37:07 INFO - Cleaning up... 03:37:07 INFO - Return code: 0 03:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37: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 03:37: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 03:37:07 INFO - Using env: {'DISPLAY': ':0', 03:37:07 INFO - 'HOME': '/home/cltbld', 03:37:07 INFO - 'LANG': 'en_US.UTF-8', 03:37:07 INFO - 'LANGUAGE': 'en_US:en', 03:37:07 INFO - 'LOGNAME': 'cltbld', 03:37:07 INFO - 'MAIL': '/var/mail/cltbld', 03:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:07 INFO - 'MOZ_NO_REMOTE': '1', 03:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:07 INFO - 'NO_EM_RESTART': '1', 03:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:07 INFO - 'PWD': '/builds/slave/test', 03:37:07 INFO - 'SHELL': '/bin/bash', 03:37:07 INFO - 'SHLVL': '1', 03:37:07 INFO - 'TERM': 'linux', 03:37:07 INFO - 'TMOUT': '86400', 03:37:07 INFO - 'USER': 'cltbld', 03:37:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:07 INFO - '_': '/tools/buildbot/bin/python'} 03:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:07 INFO - Running setup.py (path:/tmp/pip-ATrdUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:07 INFO - Running setup.py (path:/tmp/pip-iJ_HXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:07 INFO - Running setup.py (path:/tmp/pip-fR4kK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:07 INFO - Running setup.py (path:/tmp/pip-B_1gTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:07 INFO - Running setup.py (path:/tmp/pip-4d6asI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:07 INFO - Running setup.py (path:/tmp/pip-NFfNpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:07 INFO - Running setup.py (path:/tmp/pip-tHjtPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:07 INFO - Running setup.py (path:/tmp/pip-CXX9qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:07 INFO - Running setup.py (path:/tmp/pip-tw3B9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:08 INFO - Running setup.py (path:/tmp/pip-uUoj8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:08 INFO - Running setup.py (path:/tmp/pip-lf65Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:08 INFO - Running setup.py (path:/tmp/pip-ZHWzwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:08 INFO - Running setup.py (path:/tmp/pip-ODLMcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:08 INFO - Running setup.py (path:/tmp/pip-AycToo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:08 INFO - Running setup.py (path:/tmp/pip-HnkT5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:08 INFO - Running setup.py (path:/tmp/pip-mTyc11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:08 INFO - Running setup.py (path:/tmp/pip-qrg4uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:08 INFO - Running setup.py install for manifestparser 03:37:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:08 INFO - Running setup.py install for mozcrash 03:37:08 INFO - Running setup.py install for mozdebug 03:37:08 INFO - Running setup.py install for mozdevice 03:37:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozfile 03:37:09 INFO - Running setup.py install for mozhttpd 03:37:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozinfo 03:37:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozInstall 03:37:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozleak 03:37:09 INFO - Running setup.py install for mozlog 03:37:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for moznetwork 03:37:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozprocess 03:37:09 INFO - Running setup.py install for mozprofile 03:37:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:09 INFO - Running setup.py install for mozrunner 03:37:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:10 INFO - Running setup.py install for mozscreenshot 03:37:10 INFO - Running setup.py install for moztest 03:37:10 INFO - Running setup.py install for mozversion 03:37:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:10 INFO - Cleaning up... 03:37:10 INFO - Return code: 0 03:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:10 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')]} 03:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:10 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')]} 03:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:10 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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37:10 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 03:37:10 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 03:37:10 INFO - Using env: {'DISPLAY': ':0', 03:37:10 INFO - 'HOME': '/home/cltbld', 03:37:10 INFO - 'LANG': 'en_US.UTF-8', 03:37:10 INFO - 'LANGUAGE': 'en_US:en', 03:37:10 INFO - 'LOGNAME': 'cltbld', 03:37:10 INFO - 'MAIL': '/var/mail/cltbld', 03:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:10 INFO - 'MOZ_NO_REMOTE': '1', 03:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:10 INFO - 'NO_EM_RESTART': '1', 03:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:10 INFO - 'PWD': '/builds/slave/test', 03:37:10 INFO - 'SHELL': '/bin/bash', 03:37:10 INFO - 'SHLVL': '1', 03:37:10 INFO - 'TERM': 'linux', 03:37:10 INFO - 'TMOUT': '86400', 03:37:10 INFO - 'USER': 'cltbld', 03:37:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:10 INFO - '_': '/tools/buildbot/bin/python'} 03:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:10 INFO - Running setup.py (path:/tmp/pip-jAlTJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:10 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)) 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:10 INFO - Running setup.py (path:/tmp/pip-qvd5mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:10 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)) 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:10 INFO - Running setup.py (path:/tmp/pip-F8eGPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:10 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)) 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:10 INFO - Running setup.py (path:/tmp/pip-pw2miS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:10 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)) 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:10 INFO - Running setup.py (path:/tmp/pip-lMLfJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37: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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:11 INFO - Running setup.py (path:/tmp/pip-YwAiKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37: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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:11 INFO - Running setup.py (path:/tmp/pip-FlwxUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37: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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:11 INFO - Running setup.py (path:/tmp/pip-_2JQ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37: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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:11 INFO - Running setup.py (path:/tmp/pip-zheeNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37: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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:11 INFO - Running setup.py (path:/tmp/pip-QpQfzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:11 INFO - Running setup.py (path:/tmp/pip-Dh03Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:11 INFO - Running setup.py (path:/tmp/pip-sM7oYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:11 INFO - Running setup.py (path:/tmp/pip-ovDGz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:11 INFO - Running setup.py (path:/tmp/pip-cTDKhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:11 INFO - Running setup.py (path:/tmp/pip-dR8ZE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:11 INFO - Running setup.py (path:/tmp/pip-ew9hXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:11 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)) 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:11 INFO - Running setup.py (path:/tmp/pip-rZ5dSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:11 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)) 03:37:11 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)) 03:37:11 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)) 03:37:11 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)) 03:37:11 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)) 03:37:11 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)) 03:37:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:13 INFO - Downloading blessings-1.6.tar.gz 03:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:13 INFO - Installing collected packages: blessings 03:37:13 INFO - Running setup.py install for blessings 03:37:13 INFO - Successfully installed blessings 03:37:13 INFO - Cleaning up... 03:37:14 INFO - Return code: 0 03:37:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:14 INFO - Reading from file tmpfile_stdout 03:37:14 INFO - Current package versions: 03:37:14 INFO - argparse == 1.2.1 03:37:14 INFO - blessings == 1.6 03:37:14 INFO - blobuploader == 1.2.4 03:37:14 INFO - docopt == 0.6.1 03:37:14 INFO - manifestparser == 1.1 03:37:14 INFO - mozInstall == 1.12 03:37:14 INFO - mozcrash == 0.17 03:37:14 INFO - mozdebug == 0.1 03:37:14 INFO - mozdevice == 0.48 03:37:14 INFO - mozfile == 1.2 03:37:14 INFO - mozhttpd == 0.7 03:37:14 INFO - mozinfo == 0.9 03:37:14 INFO - mozleak == 0.1 03:37:14 INFO - mozlog == 3.1 03:37:14 INFO - moznetwork == 0.27 03:37:14 INFO - mozprocess == 0.22 03:37:14 INFO - mozprofile == 0.28 03:37:14 INFO - mozrunner == 6.11 03:37:14 INFO - mozscreenshot == 0.1 03:37:14 INFO - mozsystemmonitor == 0.0 03:37:14 INFO - moztest == 0.7 03:37:14 INFO - mozversion == 1.4 03:37:14 INFO - psutil == 3.1.1 03:37:14 INFO - requests == 1.2.3 03:37:14 INFO - wsgiref == 0.1.2 03:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37: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 03:37: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 03:37:14 INFO - Using env: {'DISPLAY': ':0', 03:37:14 INFO - 'HOME': '/home/cltbld', 03:37:14 INFO - 'LANG': 'en_US.UTF-8', 03:37:14 INFO - 'LANGUAGE': 'en_US:en', 03:37:14 INFO - 'LOGNAME': 'cltbld', 03:37:14 INFO - 'MAIL': '/var/mail/cltbld', 03:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:14 INFO - 'MOZ_NO_REMOTE': '1', 03:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:14 INFO - 'NO_EM_RESTART': '1', 03:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:14 INFO - 'PWD': '/builds/slave/test', 03:37:14 INFO - 'SHELL': '/bin/bash', 03:37:14 INFO - 'SHLVL': '1', 03:37:14 INFO - 'TERM': 'linux', 03:37:14 INFO - 'TMOUT': '86400', 03:37:14 INFO - 'USER': 'cltbld', 03:37:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:14 INFO - '_': '/tools/buildbot/bin/python'} 03:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 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)) 03:37:14 INFO - Cleaning up... 03:37:14 INFO - Return code: 0 03:37:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:14 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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37:14 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 03:37:14 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 03:37:14 INFO - Using env: {'DISPLAY': ':0', 03:37:14 INFO - 'HOME': '/home/cltbld', 03:37:14 INFO - 'LANG': 'en_US.UTF-8', 03:37:14 INFO - 'LANGUAGE': 'en_US:en', 03:37:14 INFO - 'LOGNAME': 'cltbld', 03:37:14 INFO - 'MAIL': '/var/mail/cltbld', 03:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:14 INFO - 'MOZ_NO_REMOTE': '1', 03:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:14 INFO - 'NO_EM_RESTART': '1', 03:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:14 INFO - 'PWD': '/builds/slave/test', 03:37:14 INFO - 'SHELL': '/bin/bash', 03:37:14 INFO - 'SHLVL': '1', 03:37:14 INFO - 'TERM': 'linux', 03:37:14 INFO - 'TMOUT': '86400', 03:37:14 INFO - 'USER': 'cltbld', 03:37:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:14 INFO - '_': '/tools/buildbot/bin/python'} 03:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:14 INFO - Downloading/unpacking jsonschema 03:37:14 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 03:37:14 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 03:37:14 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 03:37:14 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 03:37:14 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 03:37:14 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 03:37:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:16 INFO - Downloading/unpacking functools32 (from jsonschema) 03:37:16 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 03:37:16 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 03:37:16 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 03:37:16 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 03:37:16 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 03:37:16 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 03:37:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:16 INFO - warning: no files found matching '*.txt' 03:37:16 INFO - no previously-included directories found matching 'build' 03:37:16 INFO - no previously-included directories found matching 'dist' 03:37:16 INFO - no previously-included directories found matching '.git*' 03:37:17 INFO - Installing collected packages: jsonschema, functools32 03:37:17 INFO - Running setup.py install for functools32 03:37:17 INFO - warning: no files found matching '*.txt' 03:37:17 INFO - no previously-included directories found matching 'build' 03:37:17 INFO - no previously-included directories found matching 'dist' 03:37:17 INFO - no previously-included directories found matching '.git*' 03:37:17 INFO - Successfully installed jsonschema functools32 03:37:17 INFO - Cleaning up... 03:37:17 INFO - Return code: 0 03:37:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x7fcab6926f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', '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 03:37: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 03:37: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 03:37:17 INFO - Using env: {'DISPLAY': ':0', 03:37:17 INFO - 'HOME': '/home/cltbld', 03:37:17 INFO - 'LANG': 'en_US.UTF-8', 03:37:17 INFO - 'LANGUAGE': 'en_US:en', 03:37:17 INFO - 'LOGNAME': 'cltbld', 03:37:17 INFO - 'MAIL': '/var/mail/cltbld', 03:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:17 INFO - 'MOZ_NO_REMOTE': '1', 03:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:17 INFO - 'NO_EM_RESTART': '1', 03:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:17 INFO - 'PWD': '/builds/slave/test', 03:37:17 INFO - 'SHELL': '/bin/bash', 03:37:17 INFO - 'SHLVL': '1', 03:37:17 INFO - 'TERM': 'linux', 03:37:17 INFO - 'TMOUT': '86400', 03:37:17 INFO - 'USER': 'cltbld', 03:37:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:17 INFO - '_': '/tools/buildbot/bin/python'} 03:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:17 INFO - Downloading/unpacking flake8 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:37:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:37:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:19 INFO - no previously-included directories found matching 'docs/_build' 03:37:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:37:20 INFO - Running setup.py install for pep8 03:37:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:20 INFO - no previously-included directories found matching 'docs/_build' 03:37:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:37:20 INFO - Cleaning up... 03:37:20 INFO - Return code: 0 03:37:20 INFO - Running post-action listener: _resource_record_post_action 03:37:20 INFO - Running post-action listener: _start_resource_monitoring 03:37:20 INFO - Starting resource monitoring. 03:37:20 INFO - ##### 03:37:20 INFO - ##### Running install step. 03:37:20 INFO - ##### 03:37:20 INFO - Running pre-action listener: _resource_record_pre_action 03:37:20 INFO - Running main action method: install 03:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:20 INFO - Reading from file tmpfile_stdout 03:37:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:20 INFO - Reading from file tmpfile_stdout 03:37:20 INFO - Output received: 03:37:20 INFO - Usage: mozinstall [options] installer 03:37:20 INFO - Options: 03:37:20 INFO - -h, --help show this help message and exit 03:37:20 INFO - -d DEST, --destination=DEST 03:37:20 INFO - Directory to install application into. [default: 03:37:20 INFO - "/builds/slave/test"] 03:37:20 INFO - --app=APP Application being installed. [default: firefox] 03:37:20 INFO - mkdir: /builds/slave/test/build/application 03:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:37:36 INFO - Reading from file tmpfile_stdout 03:37:36 INFO - Output received: 03:37:36 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:36 INFO - Running post-action listener: _resource_record_post_action 03:37:36 INFO - ##### 03:37:36 INFO - ##### Running run-tests step. 03:37:36 INFO - ##### 03:37:36 INFO - Running pre-action listener: _resource_record_pre_action 03:37:36 INFO - Running main action method: run_tests 03:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:36 INFO - Python 2.7.3 03:37:36 INFO - Return code: 0 03:37:36 INFO - grabbing minidump binary from tooltool 03:37: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')]} 03:37: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 0x2800410>, '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 0x2801310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28017a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37: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 03:37: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 03:37:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:36 INFO - Return code: 0 03:37:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:37:37 INFO - Return code: 0 03:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 03:37:37 INFO - Using env: {'DISPLAY': ':0', 03:37:37 INFO - 'HOME': '/home/cltbld', 03:37:37 INFO - 'LANG': 'en_US.UTF-8', 03:37:37 INFO - 'LANGUAGE': 'en_US:en', 03:37:37 INFO - 'LOGNAME': 'cltbld', 03:37:37 INFO - 'MAIL': '/var/mail/cltbld', 03:37:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:37 INFO - 'MOZ_NO_REMOTE': '1', 03:37:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:37 INFO - 'NO_EM_RESTART': '1', 03:37:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:37 INFO - 'PWD': '/builds/slave/test', 03:37:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:37 INFO - 'SHELL': '/bin/bash', 03:37:37 INFO - 'SHLVL': '1', 03:37:37 INFO - 'TERM': 'linux', 03:37:37 INFO - 'TMOUT': '86400', 03:37:37 INFO - 'USER': 'cltbld', 03:37:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069', 03:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:37 INFO - '_': '/tools/buildbot/bin/python'} 03:37:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:37:37 INFO - mozversion application_buildid: 20160419025149 03:37:37 INFO - mozversion application_changeset: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 03:37:37 INFO - mozversion application_display_name: Nightly 03:37:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:37 INFO - mozversion application_name: Firefox 03:37:37 INFO - mozversion application_remotingname: firefox 03:37:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:37:37 INFO - mozversion application_vendor: Mozilla 03:37:37 INFO - mozversion application_version: 48.0a1 03:37:37 INFO - mozversion platform_buildid: 20160419025149 03:37:37 INFO - mozversion platform_changeset: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 03:37:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:37:37 INFO - mozversion platform_version: 48.0a1 03:37:37 INFO - using testdate: 1461062257 03:37:37 INFO - actual date: 1461062257 03:37:37 INFO - starting webserver on 'localhost:59326' 03:37:37 INFO - SUITE-START | Running 2 tests 03:37:37 INFO - TEST-START | dromaeo_css 03:37:37 INFO - operating with platform_type : linux_ 03:37:37 INFO - Initialising browser for dromaeo_css test... 03:37:37 INFO - TEST-INFO | started process 25929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSwpwy/profile http://localhost:59326/getInfo.html) 03:37:41 INFO - PROCESS | 25929 | 03:37:41 INFO - PROCESS | 25929 | (process:25996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:42 INFO - PROCESS | 25929 | __metrics Screen width/height:1600/1200 03:37:42 INFO - PROCESS | 25929 | colorDepth:24 03:37:42 INFO - PROCESS | 25929 | Browser inner width/height: 1024/697 03:37:42 INFO - PROCESS | 25929 | __metrics 03:37:43 ERROR - PROCESS | 25929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:37:44 INFO - TEST-INFO | 25929: exit 0 03:37:44 INFO - Browser initialized. 03:37:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:44 INFO - TEST-INFO | started process 26047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSwpwy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:46 INFO - PROCESS | 26047 | 03:37:46 INFO - PROCESS | 26047 | (process:26106): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:56 INFO - PROCESS | 26047 | RSS: Main: 164896768 03:37:56 INFO - PROCESS | 26047 | 03:38:45 INFO - PROCESS | 26047 | 1461062325718 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] 03:40:56 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59326/tests/dromaeo/cssquery-ext.html) 03:40:57 INFO - PROCESS | 26047 | RSS: Main: 169447424 03:40:57 INFO - PROCESS | 26047 | 03:43:59 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-ext.html (next: http://localhost:59326/tests/dromaeo/cssquery-jquery.html) 03:44:00 INFO - PROCESS | 26047 | RSS: Main: 166449152 03:44:00 INFO - PROCESS | 26047 | 03:47:02 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59326/tests/dromaeo/cssquery-mootools.html) 03:47:02 INFO - PROCESS | 26047 | RSS: Main: 166633472 03:47:02 INFO - PROCESS | 26047 | 03:50:04 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59326/tests/dromaeo/cssquery-prototype.html) 03:50:05 INFO - PROCESS | 26047 | RSS: Main: 164675584 03:50:05 INFO - PROCESS | 26047 | 03:53:07 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59326/tests/dromaeo/cssquery-yui.html) 03:53:08 INFO - PROCESS | 26047 | RSS: Main: 166068224 03:53:08 INFO - PROCESS | 26047 | 03:56:10 INFO - PROCESS | 26047 | Cycle 1(1): loaded http://localhost:59326/tests/dromaeo/cssquery-yui.html (next: http://localhost:59326/tests/dromaeo/cssquery-dojo.html) 03:56:11 INFO - PROCESS | 26047 | RSS: Main: 167809024 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | __start_tp_report 03:56:11 INFO - PROCESS | 26047 | _x_x_mozilla_page_load 03:56:11 INFO - PROCESS | 26047 | _x_x_mozilla_page_load_details 03:56:11 INFO - PROCESS | 26047 | |i|pagename|runs| 03:56:11 INFO - PROCESS | 26047 | |0;dojo.html;2635.973640263597;2711.1866440067975;2741.5887616857467;2745.848978306195;2758.544840101383;4706.341112244284;4728.834490792823;4731.077439899221;4739.715617062974;4768.332433459318;4662.440507139148;4676.836310729125;4758.095961767271;4797.808087676489;4825.71045737256;4287.678424118188;4350.8912277193;4356.085222103362;4357.520672725997;4359.738415695053;28.06007406766305;4260.31834906415;4265.296226122686;4283.229018776619;4409.955900441003;4327.848525301615;4374.321980093091;4376.0591472833175;4410.845620403271;4413.867583972502;4297.989972356494;4309.5690430956965;4335.653147748204;4355.172517221749;4394.758288294142;4284.164587905359;4326.783660816978;4353.41228934093;4376.584224498668;4385.890352741175;4611.654125940534;4619.16854966106;4632.791524381411;4645.163870503308;4661.7669116544375;4933.654644174909;5012.749362531858;5045.974770126162;5063.848084557432;5108.157154069574;4992.251162325644;5079.212722028092;5083.542481176712;5116.897662046776;5128.820491282824;4779.235322348442;4787.018661174451;4790.041991601694;4798.688085274446;4848.975755121272;5126.666766660155;5187.92218116721;5233.581313494911;5240.213967904845;5261.868453288698;4962.578180854595;4983.327250821165;4984.2025275955675;4987.301777751118;5004.224345226496;5025.195968645073;5029.421616514074;5043.697378157322;5061.240813877947;5118.10433174193;4772.737499437495;4939.333190019302;5030.195168772979;5056.191009438472;5059.569936555434;4968.130577148984;4968.205087186105;4975.0547395994645;4988.451270360258;5035.093683137071;4227.87316380509;4243.236217480821;4246.256905041605;4247.299195632748;4284.121755040209;3645.1616128290643;3735.290294843971;3786.1481166737262;3787.450819631138;3825.7704537727827;4268.0823622921225;4375.1031038637;4430.13612345596;4434.467863856358;4473.2842745160615;5050.029020304323;5058.974705126451;5062.797488100508;5087.898242035212;5119.6160287978555;4270.893227669271;4296.742195468282;4363.52001279859;4367.847125350598;4382.07976324969;4494.1461122386645;4500.504944456107;4501.459824820977;4524.479684836286;4589.541045895384;4787.952120478751;4789.114013907369;4790.928136077961;4792.904141917212;4795.64032697556;4914.311996320589;5025.497450254945;5039.546440820343;5046.243063540498;5085.567726743268;4774.4509381421585;4790.137775200358;4791.6406269529225;4792.113459010095;4841.983183531498;4941.209406494943;4966.925496117489;4986.426560945538;4992.650514463952;5053.090443720165;4921.409430868175;5018.824341148043;5024.371953505812;5052.747362631781;5115.897682046412;4958.504149585013;4961.975190124026;4964.900701986012;4969.875753106201;5011.749412529286;4919.0899683558655;4926.704397736147;4936.851894443173;4943.159662857251;4984.37695288089;4716.669833111787;4867.464578896248;4871.3667223260745;4882.5605695487575;4934.259861020875;4999.900002000012;5007.524285192901;5012.824551140692;5017.297578338962;5031.22016087507;4918.1393256180745;4918.827841025547;4920.31115643803;4926.4088309403105;4944.653874228769 03:56:11 INFO - PROCESS | 26047 | |1;ext.html;579.594284001199;596.2427716799662;611.0955785437553;614.8063360041587;633.5628416392692;33171.83414082929;34176.65823341766;34199.48700769484;34252.48621270677;34394.484082738745;36142.2771544569;37032.25935481295;37101.25797484049;37154.25691486169;37180.256394872085;7454.5899975501325;7677.155512893577;7685.462017658766;7690.3078722914925;7705.190954949734;7405.5556666599905;7440.069991251094;7478.775636730907;7578.886316705226;7631.923680763177;7584.2415758423995;7655.157932627434;7689.538627682357;7692.538447693129;7701.306882380584;7601.353884919761;7634.389248860078;7636.198199189089;7648.120466146409;7651.846963060708;7811.179826118289;7897.960510197412;7923.16806735296;7950;7962.761117166494;37384;37788.81105594482;37840.43239351412;37870.62129378726;38052.61947380546;2961.185673939662;3055.266735983348;3292.3250733599552;3323.5014747788027;3380.5436266104007;28435.573466398022;28575.28561785972;28872.566911496346;28883.27791805201;29299;3030.7878448508613;3035.7874948753597;3047.299121202114;3048.085574327693;3083.784135110543;225858;227315;227769;227891;228230;50939.49060509347;51585.74207129015;51710.48289517132;51743;51787.48212517826;59620.40379596235;61790;61857.072143917874;61878.38121618726;62008.689956549926;15309.693806123814;15399.230038498254;15498.922505387627;15695.058296502246;15721.292541835644;11635.476403561861;11645.184837061493;11660.650180494598;11700.06399488039;11721.88278117225;18166.27334906589;18299.085045747925;18361.54096147607;18637.534061648566;18719.812801871805;6794.150731158606;6948.131483564554;7087.89368159478;7215.242399548077;7221.783346499614;822.6627082895984;845.2097289034772;877.394597727566;974.4445665970329;1013.99493002536;28094.29764255869;28189;28630.856845716055;28769.737464934686;28900;934.3693007220099;965.6571916969515;1020.5203554329453;1060.8810098310942;1112.3326004397297;13060.608181754562;13385.06304558691;13524.391402386917;13803.2408217549;13850.584482465541;336540;338022;338615;342458;343104;48643.27035094477;49375;49595.75202123966;49636;49857.0028599426;1198.7063169523349;1227.5703503773607;1274.254561081759;1286.5175559165314;1286.594722662377;24638.630420543348;26281.21156365312;26544.336391590365;26813.463730725667;26863;39468.80265598654;39876.60123398729;40111.1977760449;40502.1899562013;40563.797181013906;293536;297539;297567;298384;299671;24997.12510062139;25551;25730;25819.870900645376;25855.0950716724;41485.37771933363;42229.5777042238;42273.577264228195;43061.3540796882;43425.782871085445;35022.29955400929;35263.471047934814;35310.29379412449;35890.4616430759;36078.8196059018;35594.822025889705;36028.4595731059;36209.27581448409;36234.4564831533;36613;34883.651163489056;36273.63726362808;36357;37198.814005929795;37346.813265933495;26777.732222678304;30907.690923090482;31537.684623153476;31838.681613183573;33451.66548334583;24747.25758227256;24751.38121546904;24804.50390992134;24889.751102488743;25177.87411062933 03:56:11 INFO - PROCESS | 26047 | |2;jquery.html;382.4168143581039;384.1759426031165;385.801312324153;393.33526340484576;396.9166475040241;15304.84695153048;16966.15169241539;17321.30714771409;17763.378281760142;17767.28930842768;16949.745753813673;17247.74128388072;17399.217035233414;17772.733408998876;17779.28882844688;5133.3839939207255;5335.759890804904;5335.839924802242;5357;5359.383670877841;3668.853245870162;5821.912671309934;6163.414475624809;6165.414285642879;6171.567990240685;5016.874578135539;6048.848778780522;6073.514118870502;6087.330393656716;6102.328743838174;5243.3970093439175;5248.448912864152;5267.420583735824;5271.314729085233;5299.894002119955;4966.801327946878;5407.621466497347;5460.426655201226;5464.426235245322;5466.617336786427;12351.073669474736;12511.687207819787;12542.996560275156;17003.23485443158;20361.898190508953;1863.7297591849106;1895.3555791031115;1923.1826473748602;1942.14545599937;1978.2680408248896;8436.367272454529;9312.255019598417;9360.344775865693;9388.62445502179;9504.334696571243;1690.6449645574444;1695.1947824783254;1722.242213426101;1723.4915699868443;1788.097011009445;69258.65370673114;70756;71168;72917;81036.59481702613;14848.331825067899;15610.97057382533;15701.842981570038;15846.841531584767;16615.169241538115;29700.40599188004;30029.099127026224;30394.240143996136;30421.39157216843;30478.54282185769;8817.735467935972;8823.69117080912;8955.552222388855;9216.400933939272;9429.3399462037;7359.852802944019;7436.144843342977;7461.776146715607;7631.321109355933;7960.6417711201975;7943.324817390471;8099.352051835839;8253.257206851293;8326.916730832736;8390.874136887951;1799.6850551153495;1913.100842603974;1935.458071739915;1936.1287420660758;1945.319138301583;822.5887056471764;931.5761328595473;941.5292353823088;962.2830990911815;990.9009099090033;16216.35134594603;16426;16903.577410564834;16982;17092.572685682957;842.0821304777821;888.5868071346725;888.7467071884482;949.349695458613;964.9614015439304;9349.532523373804;9411;9436.339456237998;9516.666916657883;9617.422954622745;380507;386363;388581;389678;393567;78228.60885695649;79087.60456197683;80128;80188;81704.18295816965;930.7440453875103;932.4265576670299;939.2251392601131;949.1220620925616;954.0268925695751;14963.551093467213;15006.174660393783;15066.623334416727;15147.318370673125;15378.769318460456;33495.83252083724;34003;34455.483167753;34855.65144348524;35344.46983295201;43443.782781085894;45843.3123503141;47645.28532071952;48365.5163448361;48374.516254837;7613.390928725578;7618.733344332922;7626.466147369631;7688.423368247292;7695.576743279174;7766.534007959314;10666.626668066581;11404.657860264206;11596.884031159918;11828.76342473163;9867.210623150275;10100.393976361147;10241.07830295277;10300;10509.421981791074;9178;9918.206543476648;9991.150752186146;10121.987801219819;10176.643817466353;7203.459740519586;10029.247806414694;10162.237832162766;10238.078572928473;10531.315464494783;7641.7707468776025;7681.1934746850775;7838.647260873388;7936.6031698416;8010.8397832041865;10277.74305642365;10312.175025998053;10398.792024159626;10517.737056573647;10525.736856578647 03:56:11 INFO - PROCESS | 26047 | |3;mootools.html;1438.4677669262371;1448.3482432905191;1597.8561929426357;1722.4832550234926;1754.8157443468444;7047.89428158578;7304.634768261586;7482.102147742272;7535.133459652142;7556.319931206183;7701.499402538845;7718.266764657363;7740.574268415249;7781.416393770462;7791.922080779204;2257.7177852768405;2277.749447560767;2290.839641225115;2294.89672964717;2297.7472478027403;2207.0950910126853;2207.23850271656;2255.672927425522;2258.0403328585367;2258.141906075689;2250.17868478006;2272.1025195047946;2278.8176945844293;2283.566122436732;2295.5753185660706;2181.1711549611205;2182.879941603211;2183.355910006544;2188.792064753846;2195.8572692774997;2164.4372463159693;2187.726534183227;2199.9560008799735;2204.7244094488187;2207.9668804967937;7791.337736292366;7857.214278572154;7887.8028049298655;7906.090799558009;7910;4659.277811939155;4803.495632958559;4816.109019831342;4824.541668541483;4827.131116399047;2787.2474431903274;2871.4400691865094;2882.956755648667;2898.3913378190605;2931.853407329625;904.683360823713;908.404994728454;918.3892711346946;925.6898938855492;949.1505102932905;10637.09584685295;10711.410872402015;10716.785664286748;10726.088282495997;10763.13894888407;4226.535081141072;4230.450041494648;4388.736675799462;4397.186520493655;4427.092446048552;9183.540822958825;9188.127127922837;9196.540172991323;9199;9216.907830921738;4830.178869592178;4833.468318484964;4891.5353041461;4898.02039592083;4900.534449227318;3695.7782533048103;4230.598093181143;4371.78141092944;4376.234159022222;4391.297392417262;3703.3519134151416;3731.6828069613844;3759.191773768653;3831.348670725983;3842.9615703843165;1182.3378907811652;1224.577520755338;1227.9877201228053;1230.5077968812548;1245.63876475821;763.522798251093;811.1320886651345;834.6285902773208;842.8705534583564;871.7166920750782;5291.523762861361;5584.497395234448;5620.494155526022;5721.542276617944;5750.25246717924;838.5471845203643;861.5606040919176;872.1191596487594;872.6553011560525;878.9516576588221;3510;3525.383057964846;3586.6234045424853;3592.3354179476883;3644.7084233261276;9255.398399104037;9600.087991640783;9613.51932403391;9732.90267097334;9775;9200.631974721071;9258.490783006864;9274.629014839466;9365.719028429157;9376.109269619375;7011.684474198673;7130.180029296697;7195.496315257987;7203.243659415791;7203.603801790847;5298.337707786527;5412.594055445778;5473.917891231555;5511.614187006871;5530.419305972976;8449.366297527587;8631.870521942301;8719.12808719123;8749.993750718495;8785.341099417441;8527.53098579584;8746.300295976434;8781.780455488408;8873.334499912404;8926.107389261022;6106.6946652668075;6740.12378390806;6864.725410983505;6892.104026476526;7084;7486.850262994819;7548.622568871425;7559.622018898923;7596.392288616787;7627.275408836152;6556.18047744032;6730.663466826737;6748.358905903931;6752.459803215829;7007;6737.090492783412;6747.156605424322;6902.723891044503;6903.5167538271835;6988.965055174692;6463.15978922737;6470;6508.251551071688;6560.343965603593;6575.947848344242;4621.560951709582;4677.251639737626;4756.595689366304;4770.761461926959;4791.353167322367;4773.1408346497965;4898.4121905371585;4923.876903077308;4939.876503087307;5006.74831292177 03:56:11 INFO - PROCESS | 26047 | |4;prototype.html;310.57296217700656;312.5998721636305;319.10491072541527;319.37083944629074;321.50809261829403;5303.204519322104;5315.14957606783;5323.441038690935;5323.893522129565;5338.119210330291;5267.631265811395;5276.393214780302;5279.683219006853;5285.339332583427;5293.9765778008705;3864.130570621616;3970.4242884781834;4099.692523060768;4103.845481122405;4104.322786740185;4083.183363327332;4095.5904409559103;4103.876883693494;4105.137921036586;4109.260333140033;4034.7780872052026;4074.5110586729634;4075.572064933184;4085.9182816343655;4088.284550203717;3801.3917773156163;4016.578259282792;4027.7180597358197;4039.7778122203267;4079.5104587449546;3524.18943642961;3533.8586456541707;3536.7347448941173;3540.9200193940837;3545.1314427965312;5034.496550344973;5068.949310506885;5078.822241221576;5081.745912704387;5086.21163719624;4533.184026875161;4581.541845815392;4652.790624421909;4657.930131048037;4665.650076244261;5498.835034948958;5511;5523.558115350762;5524.66851988882;5553.500184983371;3812.923741525154;3851.171998020411;3851.9229615407535;3862.3627101528214;3878.7866667333287;5754.273717884618;5787.913181302284;5812.505936995361;5889.617174883661;5893.58744887858;3940.3498422760495;3951.3480275754177;3966.504186976628;3971.781552014667;3975.5030621172355;4008.599140085968;4009.839606415769;4012.799360031987;4018.537868145142;4032.1734044520804;4611.838585649486;4622.2604383299185;4624.1445332613575;4642.489326174118;4643.651726120487;5440.265564148868;5535.612507124543;5547.44525547442;5551.833444996657;5560.944390556124;1391.7007843313736;1410.8589141085808;1412.1385954567706;1412.7668934625876;1416.0724725304942;867.4751775176054;901.6708901250996;936.9672061477952;957.0812020460297;959.0936564946059;4785.449673287547;4795.112904112751;4802.663813533089;4821.614270858323;4861.927071093936;5686.914696279559;5695.40198279183;5704.518534437533;5711.914321285184;5713.228714123623;4669.34629151919;4831.637627177975;4847.781849816767;4848.272759086095;4950.455449900508;3058.4189004089153;3078.5843911072166;3095.90712278632;3099.1012606343907;3102.4105419970133;5409.43200963901;5469.480399362054;5470.288862447856;5471.343438787291;5494.09347457665;5853.5317174625925;5912.260967379078;5927.451195985767;5937.168796368512;6002.159697642333;5423.7830486780085;5430.64700794455;5441.918371224356;5452.7546260417585;5485.955294811418;5664.971675141763;5767.653940763567;5771.942280577308;5825.097109947965;5830.62100963436;5691.089425691869;5712.885742285214;5716.742746576331;5739.540836732968;5746.712664366849;5392.946070539401;5455.8363249102595;5456.454354564512;5458.890822183614;5482.588805839658;3874.651281384689;3985.740926839746;3986.481757371523;3991.501062367204;4010.558838527818;5724.627899186539;5760.222369979999;5777.45114214149;5782.768689252551;5817.185594016756;5585.469380408855;5590.133529302964;5604.159376093618;5613.635113717595;5634.380218175916;5424.1321388577635;5524.563613460449;5552.666839989613;5578.581606379619;5617;5174.922376164285;5480.1231802912935;5489.204065410573;5506.91739623914;5507.531859791962;5450.700211488406;5603.159526070959;5624.437556244343;5640.830775076754;5650.180723795109;5478;5485.232067510631;5493.642913210629;5508.476694713996;5516.8966206758005 03:56:11 INFO - PROCESS | 26047 | |5;yui.html;681.6591704147926;740.5334639177318;743.1453828097686;769.4575324396301;780.9687612495499;11531.884681153186;11560;11668.883311166886;11672.35802030889;11698.707532311697;11427.657170284883;11766.705832354173;11850.407479626007;11914.285142891433;11942.582009629665;769.3383690026573;777.7783331750423;779.6764342797732;780.5355813291083;782.2881178127905;630.2500024970294;754;759.1687102622619;780.4770803561628;784.9254320839511;808.4421748993205;810.9270165685087;819.8565251081067;821.0475848016303;822.5147163173726;804.7263930263709;809.0493669937829;813.6704634622957;815.5229190923258;816.4570560577209;602.9035354343328;605.5609682979848;607.4108115128363;607.7265230646227;610.487190759764;11345.602903898407;11354.716132096764;11440.19918605698;11453.370064646524;11456.713582160513;12708.364581770968;12847.550335738299;12900.225986440844;12967.092303538757;13301.268430236332;9793.755156121082;10072.244581656405;10119.747006324827;10327.690169294932;10554.208434367452;3322.069820450278;3322.0864262328055;3343;3370.427027405347;3417.8291085445876;47023.29465058027;47595.286070708964;47872.28191577164;47962.76018619919;48065.51934480645;9907.752306192402;9916.355436896578;10062.496875156214;10064.597416103421;10257.384556926609;17050.147492625318;17133.657326853394;17203.483895483154;17266.050367229924;17664.470065898044;6552.410283074546;6617.305182955816;6764.695588698521;6804.6257455840405;6940.340667636567;3409.0454672691685;3566.7146628269675;3568.6966607838626;3587.2287458196615;3711.4247291669835;2691.1657386210336;2804.411073674551;2807.1157585360547;2818.3940452802744;2827.3921106962102;488.101892517769;491.62390771060166;496.6473803599413;501.3958180392618;509.0887311712068;596.6181643748005;597.1252115650593;602.7619090459332;605.1527860994555;635.4947816485904;7129.714811407485;7485.625718714043;7719.82056687275;7756.883646745303;7798.298153166129;549.050143252176;553.7646500237383;557.6291765975662;558.6703844731546;568.7895478672917;3749.531308586427;3769.2911586123523;3835.539735231734;3867.8646247381207;3945.0926286954164;50142;54480.18279725807;54629.1805622908;54954.45045549573;55080;46375.53624463712;47142.764286178346;47324.52675473201;47656.7617161912;47937.760311198224;42674.359884601756;42896;43164.784176078916;43824;44303.113937721064;7424.331810137113;7435.219301973431;7485.588292643739;7525.096988361432;7571.3942884568005;28028.71971280261;28084.71915280821;28419.715802842533;28575.14274571766;29198;36765;38407.80796096002;38442.65450709212;38657.613423866525;38676.80661596674;9216.539173041456;9407;9427.57575909072;9449.244060475283;9455.952720236355;10110.545025473724;10118.494075296352;10305.639302624371;10349.689509314732;10554.10290125348;9103.863442048507;9180.632774688938;9295.488748118918;9344.532773361441;9494.430334179971;8745.956270218609;9038.412503187272;9060.95469522648;9083.545822708971;9161.129692679186;9230.876549607538;9247.055315342286;9348.1119293667;9492.145706886413;9641.903580964101;8202.26179643835;8331.333493320399;8348.87476687838;8454.027786804596;8630.741077767425;7940.880886786587;8561.48631082137;8591.914080859362;8607.612657430556;8667.523286219319 03:56:11 INFO - PROCESS | 26047 | __end_tp_report 03:56:11 INFO - PROCESS | 26047 | __start_cc_report 03:56:11 INFO - PROCESS | 26047 | _x_x_mozilla_cycle_collect,370 03:56:11 INFO - PROCESS | 26047 | __end_cc_report 03:56:11 INFO - PROCESS | 26047 | __startTimestamp1461063371211__endTimestamp 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | ------- Summary: start ------- 03:56:11 INFO - PROCESS | 26047 | Number of tests: 6 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#0] dojo.html Cycles:165 Average:4650.97 Median:4797.81 stddev:602.19 (12.6%) stddev-sans-first:582.92 03:56:11 INFO - PROCESS | 26047 | Values: 2636.0 2711.2 2741.6 2745.8 2758.5 4706.3 4728.8 4731.1 4739.7 4768.3 4662.4 4676.8 4758.1 4797.8 4825.7 4287.7 4350.9 4356.1 4357.5 4359.7 28.1 4260.3 4265.3 4283.2 4410.0 4327.8 4374.3 4376.1 4410.8 4413.9 4298.0 4309.6 4335.7 4355.2 4394.8 4284.2 4326.8 4353.4 4376.6 4385.9 4611.7 4619.2 4632.8 4645.2 4661.8 4933.7 5012.7 5046.0 5063.8 5108.2 4992.3 5079.2 5083.5 5116.9 5128.8 4779.2 4787.0 4790.0 4798.7 4849.0 5126.7 5187.9 5233.6 5240.2 5261.9 4962.6 4983.3 4984.2 4987.3 5004.2 5025.2 5029.4 5043.7 5061.2 5118.1 4772.7 4939.3 5030.2 5056.2 5059.6 4968.1 4968.2 4975.1 4988.5 5035.1 4227.9 4243.2 4246.3 4247.3 4284.1 3645.2 3735.3 3786.1 3787.5 3825.8 4268.1 4375.1 4430.1 4434.5 4473.3 5050.0 5059.0 5062.8 5087.9 5119.6 4270.9 4296.7 4363.5 4367.8 4382.1 4494.1 4500.5 4501.5 4524.5 4589.5 4788.0 4789.1 4790.9 4792.9 4795.6 4914.3 5025.5 5039.5 5046.2 5085.6 4774.5 4790.1 4791.6 4792.1 4842.0 4941.2 4966.9 4986.4 4992.7 5053.1 4921.4 5018.8 5024.4 5052.7 5115.9 4958.5 4962.0 4964.9 4969.9 5011.7 4919.1 4926.7 4936.9 4943.2 4984.4 4716.7 4867.5 4871.4 4882.6 4934.3 4999.9 5007.5 5012.8 5017.3 5031.2 4918.1 4918.8 4920.3 4926.4 4944.7 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#1] ext.html Cycles:180 Average:44606.92 Median:35142.89 stddev:76571.60 (217.9%) stddev-sans-first:76715.05 03:56:11 INFO - PROCESS | 26047 | Values: 579.6 596.2 611.1 614.8 633.6 33171.8 34176.7 34199.5 34252.5 34394.5 36142.3 37032.3 37101.3 37154.3 37180.3 7454.6 7677.2 7685.5 7690.3 7705.2 7405.6 7440.1 7478.8 7578.9 7631.9 7584.2 7655.2 7689.5 7692.5 7701.3 7601.4 7634.4 7636.2 7648.1 7651.8 7811.2 7898.0 7923.2 7950.0 7962.8 37384.0 37788.8 37840.4 37870.6 38052.6 2961.2 3055.3 3292.3 3323.5 3380.5 28435.6 28575.3 28872.6 28883.3 29299.0 3030.8 3035.8 3047.3 3048.1 3083.8 225858.0 227315.0 227769.0 227891.0 228230.0 50939.5 51585.7 51710.5 51743.0 51787.5 59620.4 61790.0 61857.1 61878.4 62008.7 15309.7 15399.2 15498.9 15695.1 15721.3 11635.5 11645.2 11660.7 11700.1 11721.9 18166.3 18299.1 18361.5 18637.5 18719.8 6794.2 6948.1 7087.9 7215.2 7221.8 822.7 845.2 877.4 974.4 1014.0 28094.3 28189.0 28630.9 28769.7 28900.0 934.4 965.7 1020.5 1060.9 1112.3 13060.6 13385.1 13524.4 13803.2 13850.6 336540.0 338022.0 338615.0 342458.0 343104.0 48643.3 49375.0 49595.8 49636.0 49857.0 1198.7 1227.6 1274.3 1286.5 1286.6 24638.6 26281.2 26544.3 26813.5 26863.0 39468.8 39876.6 40111.2 40502.2 40563.8 293536.0 297539.0 297567.0 298384.0 299671.0 24997.1 25551.0 25730.0 25819.9 25855.1 41485.4 42229.6 42273.6 43061.4 43425.8 35022.3 35263.5 35310.3 35890.5 36078.8 35594.8 36028.5 36209.3 36234.5 36613.0 34883.7 36273.6 36357.0 37198.8 37346.8 26777.7 30907.7 31537.7 31838.7 33451.7 24747.3 24751.4 24804.5 24889.8 25177.9 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#2] jquery.html Cycles:180 Average:24855.80 Median:4991.84 stddev:64058.56 (1283.3%) stddev-sans-first:64211.91 03:56:11 INFO - PROCESS | 26047 | Values: 382.4 384.2 385.8 393.3 396.9 15304.8 16966.2 17321.3 17763.4 17767.3 16949.7 17247.7 17399.2 17772.7 17779.3 5133.4 5335.8 5335.8 5357.0 5359.4 3668.9 5821.9 6163.4 6165.4 6171.6 5016.9 6048.8 6073.5 6087.3 6102.3 5243.4 5248.4 5267.4 5271.3 5299.9 4966.8 5407.6 5460.4 5464.4 5466.6 12351.1 12511.7 12543.0 17003.2 20361.9 1863.7 1895.4 1923.2 1942.1 1978.3 8436.4 9312.3 9360.3 9388.6 9504.3 1690.6 1695.2 1722.2 1723.5 1788.1 69258.7 70756.0 71168.0 72917.0 81036.6 14848.3 15611.0 15701.8 15846.8 16615.2 29700.4 30029.1 30394.2 30421.4 30478.5 8817.7 8823.7 8955.6 9216.4 9429.3 7359.9 7436.1 7461.8 7631.3 7960.6 7943.3 8099.4 8253.3 8326.9 8390.9 1799.7 1913.1 1935.5 1936.1 1945.3 822.6 931.6 941.5 962.3 990.9 16216.4 16426.0 16903.6 16982.0 17092.6 842.1 888.6 888.7 949.3 965.0 9349.5 9411.0 9436.3 9516.7 9617.4 380507.0 386363.0 388581.0 389678.0 393567.0 78228.6 79087.6 80128.0 80188.0 81704.2 930.7 932.4 939.2 949.1 954.0 14963.6 15006.2 15066.6 15147.3 15378.8 33495.8 34003.0 34455.5 34855.7 35344.5 43443.8 45843.3 47645.3 48365.5 48374.5 7613.4 7618.7 7626.5 7688.4 7695.6 7766.5 10666.6 11404.7 11596.9 11828.8 9867.2 10100.4 10241.1 10300.0 10509.4 9178.0 9918.2 9991.2 10122.0 10176.6 7203.5 10029.2 10162.2 10238.1 10531.3 7641.8 7681.2 7838.6 7936.6 8010.8 10277.7 10312.2 10398.8 10517.7 10525.7 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#3] mootools.html Cycles:180 Average:5181.00 Median:5557.46 stddev:2828.04 (50.9%) stddev-sans-first:2821.98 03:56:11 INFO - PROCESS | 26047 | Values: 1438.5 1448.3 1597.9 1722.5 1754.8 7047.9 7304.6 7482.1 7535.1 7556.3 7701.5 7718.3 7740.6 7781.4 7791.9 2257.7 2277.7 2290.8 2294.9 2297.7 2207.1 2207.2 2255.7 2258.0 2258.1 2250.2 2272.1 2278.8 2283.6 2295.6 2181.2 2182.9 2183.4 2188.8 2195.9 2164.4 2187.7 2200.0 2204.7 2208.0 7791.3 7857.2 7887.8 7906.1 7910.0 4659.3 4803.5 4816.1 4824.5 4827.1 2787.2 2871.4 2883.0 2898.4 2931.9 904.7 908.4 918.4 925.7 949.2 10637.1 10711.4 10716.8 10726.1 10763.1 4226.5 4230.5 4388.7 4397.2 4427.1 9183.5 9188.1 9196.5 9199.0 9216.9 4830.2 4833.5 4891.5 4898.0 4900.5 3695.8 4230.6 4371.8 4376.2 4391.3 3703.4 3731.7 3759.2 3831.3 3843.0 1182.3 1224.6 1228.0 1230.5 1245.6 763.5 811.1 834.6 842.9 871.7 5291.5 5584.5 5620.5 5721.5 5750.3 838.5 861.6 872.1 872.7 879.0 3510.0 3525.4 3586.6 3592.3 3644.7 9255.4 9600.1 9613.5 9732.9 9775.0 9200.6 9258.5 9274.6 9365.7 9376.1 7011.7 7130.2 7195.5 7203.2 7203.6 5298.3 5412.6 5473.9 5511.6 5530.4 8449.4 8631.9 8719.1 8750.0 8785.3 8527.5 8746.3 8781.8 8873.3 8926.1 6106.7 6740.1 6864.7 6892.1 7084.0 7486.9 7548.6 7559.6 7596.4 7627.3 6556.2 6730.7 6748.4 6752.5 7007.0 6737.1 6747.2 6902.7 6903.5 6989.0 6463.2 6470.0 6508.3 6560.3 6575.9 4621.6 4677.3 4756.6 4770.8 4791.4 4773.1 4898.4 4923.9 4939.9 5006.7 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#4] prototype.html Cycles:180 Average:4600.66 Median:5298.59 stddev:1363.25 (25.7%) stddev-sans-first:1328.50 03:56:11 INFO - PROCESS | 26047 | Values: 310.6 312.6 319.1 319.4 321.5 5303.2 5315.1 5323.4 5323.9 5338.1 5267.6 5276.4 5279.7 5285.3 5294.0 3864.1 3970.4 4099.7 4103.8 4104.3 4083.2 4095.6 4103.9 4105.1 4109.3 4034.8 4074.5 4075.6 4085.9 4088.3 3801.4 4016.6 4027.7 4039.8 4079.5 3524.2 3533.9 3536.7 3540.9 3545.1 5034.5 5068.9 5078.8 5081.7 5086.2 4533.2 4581.5 4652.8 4657.9 4665.7 5498.8 5511.0 5523.6 5524.7 5553.5 3812.9 3851.2 3851.9 3862.4 3878.8 5754.3 5787.9 5812.5 5889.6 5893.6 3940.3 3951.3 3966.5 3971.8 3975.5 4008.6 4009.8 4012.8 4018.5 4032.2 4611.8 4622.3 4624.1 4642.5 4643.7 5440.3 5535.6 5547.4 5551.8 5560.9 1391.7 1410.9 1412.1 1412.8 1416.1 867.5 901.7 937.0 957.1 959.1 4785.4 4795.1 4802.7 4821.6 4861.9 5686.9 5695.4 5704.5 5711.9 5713.2 4669.3 4831.6 4847.8 4848.3 4950.5 3058.4 3078.6 3095.9 3099.1 3102.4 5409.4 5469.5 5470.3 5471.3 5494.1 5853.5 5912.3 5927.5 5937.2 6002.2 5423.8 5430.6 5441.9 5452.8 5486.0 5665.0 5767.7 5771.9 5825.1 5830.6 5691.1 5712.9 5716.7 5739.5 5746.7 5392.9 5455.8 5456.5 5458.9 5482.6 3874.7 3985.7 3986.5 3991.5 4010.6 5724.6 5760.2 5777.5 5782.8 5817.2 5585.5 5590.1 5604.2 5613.6 5634.4 5424.1 5524.6 5552.7 5578.6 5617.0 5174.9 5480.1 5489.2 5506.9 5507.5 5450.7 5603.2 5624.4 5640.8 5650.2 5478.0 5485.2 5493.6 5508.5 5516.9 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - PROCESS | 26047 | [#5] yui.html Cycles:180 Average:12496.18 Median:27751.75 stddev:14781.21 (53.3%) stddev-sans-first:14796.05 03:56:11 INFO - PROCESS | 26047 | Values: 681.7 740.5 743.1 769.5 781.0 11531.9 11560.0 11668.9 11672.4 11698.7 11427.7 11766.7 11850.4 11914.3 11942.6 769.3 777.8 779.7 780.5 782.3 630.3 754.0 759.2 780.5 784.9 808.4 810.9 819.9 821.0 822.5 804.7 809.0 813.7 815.5 816.5 602.9 605.6 607.4 607.7 610.5 11345.6 11354.7 11440.2 11453.4 11456.7 12708.4 12847.6 12900.2 12967.1 13301.3 9793.8 10072.2 10119.7 10327.7 10554.2 3322.1 3322.1 3343.0 3370.4 3417.8 47023.3 47595.3 47872.3 47962.8 48065.5 9907.8 9916.4 10062.5 10064.6 10257.4 17050.1 17133.7 17203.5 17266.1 17664.5 6552.4 6617.3 6764.7 6804.6 6940.3 3409.0 3566.7 3568.7 3587.2 3711.4 2691.2 2804.4 2807.1 2818.4 2827.4 488.1 491.6 496.6 501.4 509.1 596.6 597.1 602.8 605.2 635.5 7129.7 7485.6 7719.8 7756.9 7798.3 549.1 553.8 557.6 558.7 568.8 3749.5 3769.3 3835.5 3867.9 3945.1 50142.0 54480.2 54629.2 54954.5 55080.0 46375.5 47142.8 47324.5 47656.8 47937.8 42674.4 42896.0 43164.8 43824.0 44303.1 7424.3 7435.2 7485.6 7525.1 7571.4 28028.7 28084.7 28419.7 28575.1 29198.0 36765.0 38407.8 38442.7 38657.6 38676.8 9216.5 9407.0 9427.6 9449.2 9456.0 10110.5 10118.5 10305.6 10349.7 10554.1 9103.9 9180.6 9295.5 9344.5 9494.4 8746.0 9038.4 9061.0 9083.5 9161.1 9230.9 9247.1 9348.1 9492.1 9641.9 8202.3 8331.3 8348.9 8454.0 8630.7 7940.9 8561.5 8591.9 8607.6 8667.5 03:56:11 INFO - PROCESS | 26047 | -------- Summary: end -------- 03:56:11 INFO - PROCESS | 26047 | 03:56:11 INFO - TEST-INFO | 26047: exit 0 03:56:11 INFO - TEST-OK | dromaeo_css | took 1114410ms 03:56:11 INFO - TEST-START | kraken 03:56:11 INFO - operating with platform_type : linux_ 03:56:11 INFO - Initialising browser for kraken test... 03:56:11 INFO - TEST-INFO | started process 26283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UziR7/profile http://localhost:59326/getInfo.html) 03:56:16 INFO - PROCESS | 26283 | 03:56:16 INFO - PROCESS | 26283 | (process:26351): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:56:16 INFO - PROCESS | 26283 | __metrics Screen width/height:1600/1200 03:56:16 INFO - PROCESS | 26283 | colorDepth:24 03:56:16 INFO - PROCESS | 26283 | Browser inner width/height: 1024/697 03:56:16 INFO - PROCESS | 26283 | __metrics 03:56:17 ERROR - PROCESS | 26283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:56:18 INFO - TEST-INFO | 26283: exit 0 03:56:18 INFO - Browser initialized. 03:56:18 INFO - Running cycle 1/1 for kraken test... 03:56:18 INFO - TEST-INFO | started process 26402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UziR7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:20 INFO - PROCESS | 26402 | 03:56:20 INFO - PROCESS | 26402 | (process:26462): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:56:30 INFO - PROCESS | 26402 | RSS: Main: 164249600 03:56:30 INFO - PROCESS | 26402 | 03:56:33 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59326/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:33 INFO - PROCESS | 26402 | RSS: Main: 168583168 03:56:33 INFO - PROCESS | 26402 | 03:56:36 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59326/tests/kraken/driver.html?testName=audio-dft) 03:56:37 INFO - PROCESS | 26402 | RSS: Main: 171859968 03:56:37 INFO - PROCESS | 26402 | 03:56:40 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59326/tests/kraken/driver.html?testName=audio-fft) 03:56:41 INFO - PROCESS | 26402 | RSS: Main: 162885632 03:56:41 INFO - PROCESS | 26402 | 03:56:43 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59326/tests/kraken/driver.html?testName=audio-oscillator) 03:56:43 INFO - PROCESS | 26402 | RSS: Main: 163479552 03:56:43 INFO - PROCESS | 26402 | 03:56:46 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59326/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:46 INFO - PROCESS | 26402 | RSS: Main: 164331520 03:56:46 INFO - PROCESS | 26402 | 03:56:49 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59326/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:50 INFO - PROCESS | 26402 | RSS: Main: 163840000 03:56:50 INFO - PROCESS | 26402 | 03:56:53 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59326/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:54 INFO - PROCESS | 26402 | RSS: Main: 163307520 03:56:54 INFO - PROCESS | 26402 | 03:56:57 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59326/tests/kraken/driver.html?testName=json-parse-financial) 03:56:58 INFO - PROCESS | 26402 | RSS: Main: 164364288 03:56:58 INFO - PROCESS | 26402 | 03:56:59 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59326/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:00 INFO - PROCESS | 26402 | RSS: Main: 164618240 03:57:00 INFO - PROCESS | 26402 | 03:57:02 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:02 INFO - PROCESS | 26402 | RSS: Main: 164843520 03:57:02 INFO - PROCESS | 26402 | 03:57:05 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:05 INFO - PROCESS | 26402 | RSS: Main: 165134336 03:57:05 INFO - PROCESS | 26402 | 03:57:08 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:09 INFO - PROCESS | 26402 | RSS: Main: 165507072 03:57:09 INFO - PROCESS | 26402 | 03:57:12 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:12 INFO - PROCESS | 26402 | RSS: Main: 165044224 03:57:12 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | Cycle 1(1): loaded http://localhost:59326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59326/tests/kraken/driver.html?testName=ai-astar) 03:57:14 INFO - PROCESS | 26402 | RSS: Main: 166563840 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | __start_tp_report 03:57:14 INFO - PROCESS | 26402 | _x_x_mozilla_page_load 03:57:14 INFO - PROCESS | 26402 | _x_x_mozilla_page_load_details 03:57:14 INFO - PROCESS | 26402 | |i|pagename|runs| 03:57:14 INFO - PROCESS | 26402 | |0;ai-astar;115;109;118;114;114;127;115;115;115;113 03:57:14 INFO - PROCESS | 26402 | |1;audio-beat-detection;162;140;160;187;135;160;161;138;191;135 03:57:14 INFO - PROCESS | 26402 | |2;audio-dft;163;163;165;178;164;163;162;163;165;162 03:57:14 INFO - PROCESS | 26402 | |3;audio-fft;74;77;74;171;74;74;75;74;170;78 03:57:14 INFO - PROCESS | 26402 | |4;audio-oscillator;94;97;147;95;95;94;145;106;94;146 03:57:14 INFO - PROCESS | 26402 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 03:57:14 INFO - PROCESS | 26402 | |6;imaging-darkroom;147;148;147;148;146;148;148;148;147;147 03:57:14 INFO - PROCESS | 26402 | |7;imaging-desaturate;95;95;96;95;95;95;96;102;96;96 03:57:14 INFO - PROCESS | 26402 | |8;json-parse-financial;65;65;64;64;65;67;64;82;62;63 03:57:14 INFO - PROCESS | 26402 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;64;65;65 03:57:14 INFO - PROCESS | 26402 | |10;stanford-crypto-aes;78;79;78;80;79;80;79;81;81;82 03:57:14 INFO - PROCESS | 26402 | |11;stanford-crypto-ccm;147;135;136;141;133;136;151;136;168;135 03:57:14 INFO - PROCESS | 26402 | |12;stanford-crypto-pbkdf2;180;180;174;173;181;174;176;176;175;184 03:57:14 INFO - PROCESS | 26402 | |13;stanford-crypto-sha256-iterative;77;74;73;76;74;78;75;69;72;73 03:57:14 INFO - PROCESS | 26402 | __end_tp_report 03:57:14 INFO - PROCESS | 26402 | __start_cc_report 03:57:14 INFO - PROCESS | 26402 | _x_x_mozilla_cycle_collect,941 03:57:14 INFO - PROCESS | 26402 | __end_cc_report 03:57:14 INFO - PROCESS | 26402 | __startTimestamp1461063434921__endTimestamp 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | ------- Summary: start ------- 03:57:14 INFO - PROCESS | 26402 | Number of tests: 14 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.62 (4.0%) stddev-sans-first:4.90 03:57:14 INFO - PROCESS | 26402 | Values: 115.0 109.0 118.0 114.0 114.0 127.0 115.0 115.0 115.0 113.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:160.50 stddev:20.37 (12.7%) stddev-sans-first:21.52 03:57:14 INFO - PROCESS | 26402 | Values: 162.0 140.0 160.0 187.0 135.0 160.0 161.0 138.0 191.0 135.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.76 (2.9%) stddev-sans-first:5.00 03:57:14 INFO - PROCESS | 26402 | Values: 163.0 163.0 165.0 178.0 164.0 163.0 162.0 163.0 165.0 162.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#3] audio-fft Cycles:10 Average:94.10 Median:74.00 stddev:40.29 (54.4%) stddev-sans-first:42.07 03:57:14 INFO - PROCESS | 26402 | Values: 74.0 77.0 74.0 171.0 74.0 74.0 75.0 74.0 170.0 78.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:94.00 stddev:24.21 (25.8%) stddev-sans-first:24.86 03:57:14 INFO - PROCESS | 26402 | Values: 94.0 97.0 147.0 95.0 95.0 94.0 145.0 106.0 94.0 146.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:57:14 INFO - PROCESS | 26402 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:57:14 INFO - PROCESS | 26402 | Values: 147.0 148.0 147.0 148.0 146.0 148.0 148.0 148.0 147.0 147.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:2.13 (2.2%) stddev-sans-first:2.22 03:57:14 INFO - PROCESS | 26402 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 102.0 96.0 96.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:5.74 (8.8%) stddev-sans-first:6.08 03:57:14 INFO - PROCESS | 26402 | Values: 65.0 65.0 64.0 64.0 65.0 67.0 64.0 82.0 62.0 63.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 03:57:14 INFO - PROCESS | 26402 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.34 (1.7%) stddev-sans-first:1.27 03:57:14 INFO - PROCESS | 26402 | Values: 78.0 79.0 78.0 80.0 79.0 80.0 79.0 81.0 81.0 82.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:138.50 stddev:10.90 (7.9%) stddev-sans-first:11.40 03:57:14 INFO - PROCESS | 26402 | Values: 147.0 135.0 136.0 141.0 133.0 136.0 151.0 136.0 168.0 135.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:178.00 stddev:3.68 (2.1%) stddev-sans-first:3.77 03:57:14 INFO - PROCESS | 26402 | Values: 180.0 180.0 174.0 173.0 181.0 174.0 176.0 176.0 175.0 184.0 03:57:14 INFO - PROCESS | 26402 | 03:57:14 INFO - PROCESS | 26402 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.50 stddev:2.60 (3.5%) stddev-sans-first:2.54 03:57:14 INFO - PROCESS | 26402 | Values: 77.0 74.0 73.0 76.0 74.0 78.0 75.0 69.0 72.0 73.0 03:57:14 INFO - PROCESS | 26402 | -------- Summary: end -------- 03:57:14 INFO - PROCESS | 26402 | 03:57:15 INFO - TEST-INFO | 26402: exit 0 03:57:15 INFO - TEST-OK | kraken | took 63979ms 03:57:15 INFO - SUITE-END | took 1178s 03:57:16 INFO - Completed test suite (00:19:38) 03:57:16 INFO - javascript benchmark 03:57:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.973640263597, 2711.1866440067975, 2741.5887616857467, 2745.848978306195, 2758.544840101383, 4706.341112244284, 4728.834490792823, 4731.077439899221, 4739.715617062974, 4768.332433459318, 4662.440507139148, 4676.836310729125, 4758.095961767271, 4797.808087676489, 4825.71045737256, 4287.678424118188, 4350.8912277193, 4356.085222103362, 4357.520672725997, 4359.738415695053, 28.06007406766305, 4260.31834906415, 4265.296226122686, 4283.229018776619, 4409.955900441003, 4327.848525301615, 4374.321980093091, 4376.0591472833175, 4410.845620403271, 4413.867583972502, 4297.989972356494, 4309.5690430956965, 4335.653147748204, 4355.172517221749, 4394.758288294142, 4284.164587905359, 4326.783660816978, 4353.41228934093, 4376.584224498668, 4385.890352741175, 4611.654125940534, 4619.16854966106, 4632.791524381411, 4645.163870503308, 4661.7669116544375, 4933.654644174909, 5012.749362531858, 5045.974770126162, 5063.848084557432, 5108.157154069574, 4992.251162325644, 5079.212722028092, 5083.542481176712, 5116.897662046776, 5128.820491282824, 4779.235322348442, 4787.018661174451, 4790.041991601694, 4798.688085274446, 4848.975755121272, 5126.666766660155, 5187.92218116721, 5233.581313494911, 5240.213967904845, 5261.868453288698, 4962.578180854595, 4983.327250821165, 4984.2025275955675, 4987.301777751118, 5004.224345226496, 5025.195968645073, 5029.421616514074, 5043.697378157322, 5061.240813877947, 5118.10433174193, 4772.737499437495, 4939.333190019302, 5030.195168772979, 5056.191009438472, 5059.569936555434, 4968.130577148984, 4968.205087186105, 4975.0547395994645, 4988.451270360258, 5035.093683137071, 4227.87316380509, 4243.236217480821, 4246.256905041605, 4247.299195632748, 4284.121755040209, 3645.1616128290643, 3735.290294843971, 3786.1481166737262, 3787.450819631138, 3825.7704537727827, 4268.0823622921225, 4375.1031038637, 4430.13612345596, 4434.467863856358, 4473.2842745160615, 5050.029020304323, 5058.974705126451, 5062.797488100508, 5087.898242035212, 5119.6160287978555, 4270.893227669271, 4296.742195468282, 4363.52001279859, 4367.847125350598, 4382.07976324969, 4494.1461122386645, 4500.504944456107, 4501.459824820977, 4524.479684836286, 4589.541045895384, 4787.952120478751, 4789.114013907369, 4790.928136077961, 4792.904141917212, 4795.64032697556, 4914.311996320589, 5025.497450254945, 5039.546440820343, 5046.243063540498, 5085.567726743268, 4774.4509381421585, 4790.137775200358, 4791.6406269529225, 4792.113459010095, 4841.983183531498, 4941.209406494943, 4966.925496117489, 4986.426560945538, 4992.650514463952, 5053.090443720165, 4921.409430868175, 5018.824341148043, 5024.371953505812, 5052.747362631781, 5115.897682046412, 4958.504149585013, 4961.975190124026, 4964.900701986012, 4969.875753106201, 5011.749412529286, 4919.0899683558655, 4926.704397736147, 4936.851894443173, 4943.159662857251, 4984.37695288089, 4716.669833111787, 4867.464578896248, 4871.3667223260745, 4882.5605695487575, 4934.259861020875, 4999.900002000012, 5007.524285192901, 5012.824551140692, 5017.297578338962, 5031.22016087507, 4918.1393256180745, 4918.827841025547, 4920.31115643803, 4926.4088309403105, 4944.653874228769], "value": 4616.016651034852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.594284001199, 596.2427716799662, 611.0955785437553, 614.8063360041587, 633.5628416392692, 33171.83414082929, 34176.65823341766, 34199.48700769484, 34252.48621270677, 34394.484082738745, 36142.2771544569, 37032.25935481295, 37101.25797484049, 37154.25691486169, 37180.256394872085, 7454.5899975501325, 7677.155512893577, 7685.462017658766, 7690.3078722914925, 7705.190954949734, 7405.5556666599905, 7440.069991251094, 7478.775636730907, 7578.886316705226, 7631.923680763177, 7584.2415758423995, 7655.157932627434, 7689.538627682357, 7692.538447693129, 7701.306882380584, 7601.353884919761, 7634.389248860078, 7636.198199189089, 7648.120466146409, 7651.846963060708, 7811.179826118289, 7897.960510197412, 7923.16806735296, 7950.0, 7962.761117166494, 37384.0, 37788.81105594482, 37840.43239351412, 37870.62129378726, 38052.61947380546, 2961.185673939662, 3055.266735983348, 3292.3250733599552, 3323.5014747788027, 3380.5436266104007, 28435.573466398022, 28575.28561785972, 28872.566911496346, 28883.27791805201, 29299.0, 3030.7878448508613, 3035.7874948753597, 3047.299121202114, 3048.085574327693, 3083.784135110543, 225858.0, 227315.0, 227769.0, 227891.0, 228230.0, 50939.49060509347, 51585.74207129015, 51710.48289517132, 51743.0, 51787.48212517826, 59620.40379596235, 61790.0, 61857.072143917874, 61878.38121618726, 62008.689956549926, 15309.693806123814, 15399.230038498254, 15498.922505387627, 15695.058296502246, 15721.292541835644, 11635.476403561861, 11645.184837061493, 11660.650180494598, 11700.06399488039, 11721.88278117225, 18166.27334906589, 18299.085045747925, 18361.54096147607, 18637.534061648566, 18719.812801871805, 6794.150731158606, 6948.131483564554, 7087.89368159478, 7215.242399548077, 7221.783346499614, 822.6627082895984, 845.2097289034772, 877.394597727566, 974.4445665970329, 1013.99493002536, 28094.29764255869, 28189.0, 28630.856845716055, 28769.737464934686, 28900.0, 934.3693007220099, 965.6571916969515, 1020.5203554329453, 1060.8810098310942, 1112.3326004397297, 13060.608181754562, 13385.06304558691, 13524.391402386917, 13803.2408217549, 13850.584482465541, 336540.0, 338022.0, 338615.0, 342458.0, 343104.0, 48643.27035094477, 49375.0, 49595.75202123966, 49636.0, 49857.0028599426, 1198.7063169523349, 1227.5703503773607, 1274.254561081759, 1286.5175559165314, 1286.594722662377, 24638.630420543348, 26281.21156365312, 26544.336391590365, 26813.463730725667, 26863.0, 39468.80265598654, 39876.60123398729, 40111.1977760449, 40502.1899562013, 40563.797181013906, 293536.0, 297539.0, 297567.0, 298384.0, 299671.0, 24997.12510062139, 25551.0, 25730.0, 25819.870900645376, 25855.0950716724, 41485.37771933363, 42229.5777042238, 42273.577264228195, 43061.3540796882, 43425.782871085445, 35022.29955400929, 35263.471047934814, 35310.29379412449, 35890.4616430759, 36078.8196059018, 35594.822025889705, 36028.4595731059, 36209.27581448409, 36234.4564831533, 36613.0, 34883.651163489056, 36273.63726362808, 36357.0, 37198.814005929795, 37346.813265933495, 26777.732222678304, 30907.690923090482, 31537.684623153476, 31838.681613183573, 33451.66548334583, 24747.25758227256, 24751.38121546904, 24804.50390992134, 24889.751102488743, 25177.87411062933], "value": 17253.2069633158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4168143581039, 384.1759426031165, 385.801312324153, 393.33526340484576, 396.9166475040241, 15304.84695153048, 16966.15169241539, 17321.30714771409, 17763.378281760142, 17767.28930842768, 16949.745753813673, 17247.74128388072, 17399.217035233414, 17772.733408998876, 17779.28882844688, 5133.3839939207255, 5335.759890804904, 5335.839924802242, 5357.0, 5359.383670877841, 3668.853245870162, 5821.912671309934, 6163.414475624809, 6165.414285642879, 6171.567990240685, 5016.874578135539, 6048.848778780522, 6073.514118870502, 6087.330393656716, 6102.328743838174, 5243.3970093439175, 5248.448912864152, 5267.420583735824, 5271.314729085233, 5299.894002119955, 4966.801327946878, 5407.621466497347, 5460.426655201226, 5464.426235245322, 5466.617336786427, 12351.073669474736, 12511.687207819787, 12542.996560275156, 17003.23485443158, 20361.898190508953, 1863.7297591849106, 1895.3555791031115, 1923.1826473748602, 1942.14545599937, 1978.2680408248896, 8436.367272454529, 9312.255019598417, 9360.344775865693, 9388.62445502179, 9504.334696571243, 1690.6449645574444, 1695.1947824783254, 1722.242213426101, 1723.4915699868443, 1788.097011009445, 69258.65370673114, 70756.0, 71168.0, 72917.0, 81036.59481702613, 14848.331825067899, 15610.97057382533, 15701.842981570038, 15846.841531584767, 16615.169241538115, 29700.40599188004, 30029.099127026224, 30394.240143996136, 30421.39157216843, 30478.54282185769, 8817.735467935972, 8823.69117080912, 8955.552222388855, 9216.400933939272, 9429.3399462037, 7359.852802944019, 7436.144843342977, 7461.776146715607, 7631.321109355933, 7960.6417711201975, 7943.324817390471, 8099.352051835839, 8253.257206851293, 8326.916730832736, 8390.874136887951, 1799.6850551153495, 1913.100842603974, 1935.458071739915, 1936.1287420660758, 1945.319138301583, 822.5887056471764, 931.5761328595473, 941.5292353823088, 962.2830990911815, 990.9009099090033, 16216.35134594603, 16426.0, 16903.577410564834, 16982.0, 17092.572685682957, 842.0821304777821, 888.5868071346725, 888.7467071884482, 949.349695458613, 964.9614015439304, 9349.532523373804, 9411.0, 9436.339456237998, 9516.666916657883, 9617.422954622745, 380507.0, 386363.0, 388581.0, 389678.0, 393567.0, 78228.60885695649, 79087.60456197683, 80128.0, 80188.0, 81704.18295816965, 930.7440453875103, 932.4265576670299, 939.2251392601131, 949.1220620925616, 954.0268925695751, 14963.551093467213, 15006.174660393783, 15066.623334416727, 15147.318370673125, 15378.769318460456, 33495.83252083724, 34003.0, 34455.483167753, 34855.65144348524, 35344.46983295201, 43443.782781085894, 45843.3123503141, 47645.28532071952, 48365.5163448361, 48374.516254837, 7613.390928725578, 7618.733344332922, 7626.466147369631, 7688.423368247292, 7695.576743279174, 7766.534007959314, 10666.626668066581, 11404.657860264206, 11596.884031159918, 11828.76342473163, 9867.210623150275, 10100.393976361147, 10241.07830295277, 10300.0, 10509.421981791074, 9178.0, 9918.206543476648, 9991.150752186146, 10121.987801219819, 10176.643817466353, 7203.459740519586, 10029.247806414694, 10162.237832162766, 10238.078572928473, 10531.315464494783, 7641.7707468776025, 7681.1934746850775, 7838.647260873388, 7936.6031698416, 8010.8397832041865, 10277.74305642365, 10312.175025998053, 10398.792024159626, 10517.737056573647, 10525.736856578647], "value": 8669.917523330781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.4677669262371, 1448.3482432905191, 1597.8561929426357, 1722.4832550234926, 1754.8157443468444, 7047.89428158578, 7304.634768261586, 7482.102147742272, 7535.133459652142, 7556.319931206183, 7701.499402538845, 7718.266764657363, 7740.574268415249, 7781.416393770462, 7791.922080779204, 2257.7177852768405, 2277.749447560767, 2290.839641225115, 2294.89672964717, 2297.7472478027403, 2207.0950910126853, 2207.23850271656, 2255.672927425522, 2258.0403328585367, 2258.141906075689, 2250.17868478006, 2272.1025195047946, 2278.8176945844293, 2283.566122436732, 2295.5753185660706, 2181.1711549611205, 2182.879941603211, 2183.355910006544, 2188.792064753846, 2195.8572692774997, 2164.4372463159693, 2187.726534183227, 2199.9560008799735, 2204.7244094488187, 2207.9668804967937, 7791.337736292366, 7857.214278572154, 7887.8028049298655, 7906.090799558009, 7910.0, 4659.277811939155, 4803.495632958559, 4816.109019831342, 4824.541668541483, 4827.131116399047, 2787.2474431903274, 2871.4400691865094, 2882.956755648667, 2898.3913378190605, 2931.853407329625, 904.683360823713, 908.404994728454, 918.3892711346946, 925.6898938855492, 949.1505102932905, 10637.09584685295, 10711.410872402015, 10716.785664286748, 10726.088282495997, 10763.13894888407, 4226.535081141072, 4230.450041494648, 4388.736675799462, 4397.186520493655, 4427.092446048552, 9183.540822958825, 9188.127127922837, 9196.540172991323, 9199.0, 9216.907830921738, 4830.178869592178, 4833.468318484964, 4891.5353041461, 4898.02039592083, 4900.534449227318, 3695.7782533048103, 4230.598093181143, 4371.78141092944, 4376.234159022222, 4391.297392417262, 3703.3519134151416, 3731.6828069613844, 3759.191773768653, 3831.348670725983, 3842.9615703843165, 1182.3378907811652, 1224.577520755338, 1227.9877201228053, 1230.5077968812548, 1245.63876475821, 763.522798251093, 811.1320886651345, 834.6285902773208, 842.8705534583564, 871.7166920750782, 5291.523762861361, 5584.497395234448, 5620.494155526022, 5721.542276617944, 5750.25246717924, 838.5471845203643, 861.5606040919176, 872.1191596487594, 872.6553011560525, 878.9516576588221, 3510.0, 3525.383057964846, 3586.6234045424853, 3592.3354179476883, 3644.7084233261276, 9255.398399104037, 9600.087991640783, 9613.51932403391, 9732.90267097334, 9775.0, 9200.631974721071, 9258.490783006864, 9274.629014839466, 9365.719028429157, 9376.109269619375, 7011.684474198673, 7130.180029296697, 7195.496315257987, 7203.243659415791, 7203.603801790847, 5298.337707786527, 5412.594055445778, 5473.917891231555, 5511.614187006871, 5530.419305972976, 8449.366297527587, 8631.870521942301, 8719.12808719123, 8749.993750718495, 8785.341099417441, 8527.53098579584, 8746.300295976434, 8781.780455488408, 8873.334499912404, 8926.107389261022, 6106.6946652668075, 6740.12378390806, 6864.725410983505, 6892.104026476526, 7084.0, 7486.850262994819, 7548.622568871425, 7559.622018898923, 7596.392288616787, 7627.275408836152, 6556.18047744032, 6730.663466826737, 6748.358905903931, 6752.459803215829, 7007.0, 6737.090492783412, 6747.156605424322, 6902.723891044503, 6903.5167538271835, 6988.965055174692, 6463.15978922737, 6470.0, 6508.251551071688, 6560.343965603593, 6575.947848344242, 4621.560951709582, 4677.251639737626, 4756.595689366304, 4770.761461926959, 4791.353167322367, 4773.1408346497965, 4898.4121905371585, 4923.876903077308, 4939.876503087307, 5006.74831292177], "value": 4200.866192693075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.57296217700656, 312.5998721636305, 319.10491072541527, 319.37083944629074, 321.50809261829403, 5303.204519322104, 5315.14957606783, 5323.441038690935, 5323.893522129565, 5338.119210330291, 5267.631265811395, 5276.393214780302, 5279.683219006853, 5285.339332583427, 5293.9765778008705, 3864.130570621616, 3970.4242884781834, 4099.692523060768, 4103.845481122405, 4104.322786740185, 4083.183363327332, 4095.5904409559103, 4103.876883693494, 4105.137921036586, 4109.260333140033, 4034.7780872052026, 4074.5110586729634, 4075.572064933184, 4085.9182816343655, 4088.284550203717, 3801.3917773156163, 4016.578259282792, 4027.7180597358197, 4039.7778122203267, 4079.5104587449546, 3524.18943642961, 3533.8586456541707, 3536.7347448941173, 3540.9200193940837, 3545.1314427965312, 5034.496550344973, 5068.949310506885, 5078.822241221576, 5081.745912704387, 5086.21163719624, 4533.184026875161, 4581.541845815392, 4652.790624421909, 4657.930131048037, 4665.650076244261, 5498.835034948958, 5511.0, 5523.558115350762, 5524.66851988882, 5553.500184983371, 3812.923741525154, 3851.171998020411, 3851.9229615407535, 3862.3627101528214, 3878.7866667333287, 5754.273717884618, 5787.913181302284, 5812.505936995361, 5889.617174883661, 5893.58744887858, 3940.3498422760495, 3951.3480275754177, 3966.504186976628, 3971.781552014667, 3975.5030621172355, 4008.599140085968, 4009.839606415769, 4012.799360031987, 4018.537868145142, 4032.1734044520804, 4611.838585649486, 4622.2604383299185, 4624.1445332613575, 4642.489326174118, 4643.651726120487, 5440.265564148868, 5535.612507124543, 5547.44525547442, 5551.833444996657, 5560.944390556124, 1391.7007843313736, 1410.8589141085808, 1412.1385954567706, 1412.7668934625876, 1416.0724725304942, 867.4751775176054, 901.6708901250996, 936.9672061477952, 957.0812020460297, 959.0936564946059, 4785.449673287547, 4795.112904112751, 4802.663813533089, 4821.614270858323, 4861.927071093936, 5686.914696279559, 5695.40198279183, 5704.518534437533, 5711.914321285184, 5713.228714123623, 4669.34629151919, 4831.637627177975, 4847.781849816767, 4848.272759086095, 4950.455449900508, 3058.4189004089153, 3078.5843911072166, 3095.90712278632, 3099.1012606343907, 3102.4105419970133, 5409.43200963901, 5469.480399362054, 5470.288862447856, 5471.343438787291, 5494.09347457665, 5853.5317174625925, 5912.260967379078, 5927.451195985767, 5937.168796368512, 6002.159697642333, 5423.7830486780085, 5430.64700794455, 5441.918371224356, 5452.7546260417585, 5485.955294811418, 5664.971675141763, 5767.653940763567, 5771.942280577308, 5825.097109947965, 5830.62100963436, 5691.089425691869, 5712.885742285214, 5716.742746576331, 5739.540836732968, 5746.712664366849, 5392.946070539401, 5455.8363249102595, 5456.454354564512, 5458.890822183614, 5482.588805839658, 3874.651281384689, 3985.740926839746, 3986.481757371523, 3991.501062367204, 4010.558838527818, 5724.627899186539, 5760.222369979999, 5777.45114214149, 5782.768689252551, 5817.185594016756, 5585.469380408855, 5590.133529302964, 5604.159376093618, 5613.635113717595, 5634.380218175916, 5424.1321388577635, 5524.563613460449, 5552.666839989613, 5578.581606379619, 5617.0, 5174.922376164285, 5480.1231802912935, 5489.204065410573, 5506.91739623914, 5507.531859791962, 5450.700211488406, 5603.159526070959, 5624.437556244343, 5640.830775076754, 5650.180723795109, 5478.0, 5485.232067510631, 5493.642913210629, 5508.476694713996, 5516.8966206758005], "value": 4164.313599756925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.6591704147926, 740.5334639177318, 743.1453828097686, 769.4575324396301, 780.9687612495499, 11531.884681153186, 11560.0, 11668.883311166886, 11672.35802030889, 11698.707532311697, 11427.657170284883, 11766.705832354173, 11850.407479626007, 11914.285142891433, 11942.582009629665, 769.3383690026573, 777.7783331750423, 779.6764342797732, 780.5355813291083, 782.2881178127905, 630.2500024970294, 754.0, 759.1687102622619, 780.4770803561628, 784.9254320839511, 808.4421748993205, 810.9270165685087, 819.8565251081067, 821.0475848016303, 822.5147163173726, 804.7263930263709, 809.0493669937829, 813.6704634622957, 815.5229190923258, 816.4570560577209, 602.9035354343328, 605.5609682979848, 607.4108115128363, 607.7265230646227, 610.487190759764, 11345.602903898407, 11354.716132096764, 11440.19918605698, 11453.370064646524, 11456.713582160513, 12708.364581770968, 12847.550335738299, 12900.225986440844, 12967.092303538757, 13301.268430236332, 9793.755156121082, 10072.244581656405, 10119.747006324827, 10327.690169294932, 10554.208434367452, 3322.069820450278, 3322.0864262328055, 3343.0, 3370.427027405347, 3417.8291085445876, 47023.29465058027, 47595.286070708964, 47872.28191577164, 47962.76018619919, 48065.51934480645, 9907.752306192402, 9916.355436896578, 10062.496875156214, 10064.597416103421, 10257.384556926609, 17050.147492625318, 17133.657326853394, 17203.483895483154, 17266.050367229924, 17664.470065898044, 6552.410283074546, 6617.305182955816, 6764.695588698521, 6804.6257455840405, 6940.340667636567, 3409.0454672691685, 3566.7146628269675, 3568.6966607838626, 3587.2287458196615, 3711.4247291669835, 2691.1657386210336, 2804.411073674551, 2807.1157585360547, 2818.3940452802744, 2827.3921106962102, 488.101892517769, 491.62390771060166, 496.6473803599413, 501.3958180392618, 509.0887311712068, 596.6181643748005, 597.1252115650593, 602.7619090459332, 605.1527860994555, 635.4947816485904, 7129.714811407485, 7485.625718714043, 7719.82056687275, 7756.883646745303, 7798.298153166129, 549.050143252176, 553.7646500237383, 557.6291765975662, 558.6703844731546, 568.7895478672917, 3749.531308586427, 3769.2911586123523, 3835.539735231734, 3867.8646247381207, 3945.0926286954164, 50142.0, 54480.18279725807, 54629.1805622908, 54954.45045549573, 55080.0, 46375.53624463712, 47142.764286178346, 47324.52675473201, 47656.7617161912, 47937.760311198224, 42674.359884601756, 42896.0, 43164.784176078916, 43824.0, 44303.113937721064, 7424.331810137113, 7435.219301973431, 7485.588292643739, 7525.096988361432, 7571.3942884568005, 28028.71971280261, 28084.71915280821, 28419.715802842533, 28575.14274571766, 29198.0, 36765.0, 38407.80796096002, 38442.65450709212, 38657.613423866525, 38676.80661596674, 9216.539173041456, 9407.0, 9427.57575909072, 9449.244060475283, 9455.952720236355, 10110.545025473724, 10118.494075296352, 10305.639302624371, 10349.689509314732, 10554.10290125348, 9103.863442048507, 9180.632774688938, 9295.488748118918, 9344.532773361441, 9494.430334179971, 8745.956270218609, 9038.412503187272, 9060.95469522648, 9083.545822708971, 9161.129692679186, 9230.876549607538, 9247.055315342286, 9348.1119293667, 9492.145706886413, 9641.903580964101, 8202.26179643835, 8331.333493320399, 8348.87476687838, 8454.027786804596, 8630.741077767425, 7940.880886786587, 8561.48631082137, 8591.914080859362, 8607.612657430556, 8667.523286219319], "value": 5695.9915600252125, "unit": "score"}], "name": "dromaeo_css", "value": 6401.4004288092865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 118.0, 114.0, 114.0, 127.0, 115.0, 115.0, 115.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 140.0, 160.0, 187.0, 135.0, 160.0, 161.0, 138.0, 191.0, 135.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 178.0, 164.0, 163.0, 162.0, 163.0, 165.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 171.0, 74.0, 74.0, 75.0, 74.0, 170.0, 78.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 147.0, 95.0, 95.0, 94.0, 145.0, 106.0, 94.0, 146.0], "value": 111.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 102.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 67.0, 64.0, 82.0, 62.0, 63.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 80.0, 79.0, 80.0, 79.0, 81.0, 81.0, 82.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 135.0, 136.0, 141.0, 133.0, 136.0, 151.0, 136.0, 168.0, 135.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 174.0, 173.0, 181.0, 174.0, 176.0, 176.0, 175.0, 184.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 73.0, 76.0, 74.0, 78.0, 75.0, 69.0, 72.0, 73.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1607.1999999999998, "alertThreshold": 2.0}]} 03:57:16 INFO - Return code: 0 03:57:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:57:16 ERROR - # TBPL SUCCESS # 03:57:16 INFO - Running post-action listener: _resource_record_post_action 03:57:16 INFO - Running post-run listener: _resource_record_post_run 03:57:17 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 518090752; Read time: 0; Write time: 442136 03:57:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234270720; Read time: 0; Write time: 242416 03:57:17 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283820032; Read time: 0; Write time: 199720 03:57:17 INFO - Running post-run listener: _upload_blobber_files 03:57:17 INFO - Blob upload gear active. 03:57:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57: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 03:57: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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57: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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:18 INFO - (blobuploader) - INFO - Done attempting. 03:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:19 INFO - (blobuploader) - INFO - Done attempting. 03:57:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:19 INFO - Return code: 0 03:57:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dafc0c5176ac278a7894e25594a590524678b2926b26981cafafae846553f5b2292e1d1d53f7d50e351cd9764921a3923f5601e48b50208050d32eb08c5da6cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdba91df4dfe2a9361b6d57012207083a9e1061e0fe7c105dc08894575bcc81ef3a14efb14731be87f2381af9533a909764419927a5c1be45be86ccc76851f3f"} 03:57:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:19 INFO - Contents: 03:57:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dafc0c5176ac278a7894e25594a590524678b2926b26981cafafae846553f5b2292e1d1d53f7d50e351cd9764921a3923f5601e48b50208050d32eb08c5da6cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdba91df4dfe2a9361b6d57012207083a9e1061e0fe7c105dc08894575bcc81ef3a14efb14731be87f2381af9533a909764419927a5c1be45be86ccc76851f3f"} 03:57:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:19 INFO - Copying logs to upload dir... 03:57:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.443498 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-19 03:57:19.403868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 03:57:19.407501) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 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/Fx-Team-Non-PGO/sha512/dafc0c5176ac278a7894e25594a590524678b2926b26981cafafae846553f5b2292e1d1d53f7d50e351cd9764921a3923f5601e48b50208050d32eb08c5da6cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdba91df4dfe2a9361b6d57012207083a9e1061e0fe7c105dc08894575bcc81ef3a14efb14731be87f2381af9533a909764419927a5c1be45be86ccc76851f3f"} build_url:https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/T6aIlNWuSomsQU6MaEtIuw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dafc0c5176ac278a7894e25594a590524678b2926b26981cafafae846553f5b2292e1d1d53f7d50e351cd9764921a3923f5601e48b50208050d32eb08c5da6cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdba91df4dfe2a9361b6d57012207083a9e1061e0fe7c105dc08894575bcc81ef3a14efb14731be87f2381af9533a909764419927a5c1be45be86ccc76851f3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 03:57:19.432198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:57:19.432552) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461062204.623342-1897863069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:57:19.515057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 03:57:19.515388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 03:57:19.515703) ========= ========= Total master_lag: 0.17 =========