builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1462883319.18 results: success (0) buildid: 20160510044311 builduid: 5be4e77192d14761bc6040da40f2aee3 revision: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.177500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.177950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.178235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.194441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.194760) ========= 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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 05:28:40-- 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% 12.8M=0.001s 2016-05-10 05:28:40 (12.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129697 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.337801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.338153) ========= 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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017979 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.387589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.387956) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f9351bae69d056e4615d21dda6bf42fec5d16b7 --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 2f9351bae69d056e4615d21dda6bf42fec5d16b7 --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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 05:28:40,421 truncating revision to first 12 chars 2016-05-10 05:28:40,421 Setting DEBUG logging. 2016-05-10 05:28:40,421 attempt 1/10 2016-05-10 05:28:40,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f9351bae69d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 05:28:40,675 unpacking tar archive at: fx-team-2f9351bae69d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.942554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.942888) ========= script_repo_revision: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.943297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.943591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:28:39.953165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 05:28:39.953566) ========= /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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:41 INFO - MultiFileLogger online at 20160510 05:28:41 in /builds/slave/test 05:28:41 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 05:28:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:28:41 INFO - {'append_to_log': False, 05:28:41 INFO - 'base_work_dir': '/builds/slave/test', 05:28:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:28:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:28:41 INFO - 'branch': 'Fx-Team-Non-PGO', 05:28:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:41 INFO - 'config_files': ('talos/linux_config.py',), 05:28:41 INFO - 'default_actions': ('clobber', 05:28:41 INFO - 'read-buildbot-config', 05:28:41 INFO - 'download-and-extract', 05:28:41 INFO - 'populate-webroot', 05:28:41 INFO - 'create-virtualenv', 05:28:41 INFO - 'install', 05:28:41 INFO - 'run-tests'), 05:28:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:41 INFO - 'download_minidump_stackwalk': True, 05:28:41 INFO - 'download_symbols': 'ondemand', 05:28:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:28:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:28:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:28:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:28:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:41 INFO - 'installer_path': 'installer.exe', 05:28:41 INFO - 'log_level': 'info', 05:28:41 INFO - 'log_name': 'talos', 05:28:41 INFO - 'log_to_console': True, 05:28:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:41 INFO - 'opt_config_files': (), 05:28:41 INFO - 'pip_index': False, 05:28:41 INFO - 'sps_profile': False, 05:28:41 INFO - 'sps_profile_interval': 0, 05:28:41 INFO - 'suite': 'dromaeojs-e10s', 05:28:41 INFO - 'system_bits': '32', 05:28:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:41 INFO - 'title': 'talos-linux64-ix-044', 05:28:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:41 INFO - 'use_talos_json': True, 05:28:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:28:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:41 INFO - 'work_dir': 'build'} 05:28:41 INFO - ##### 05:28:41 INFO - ##### Running clobber step. 05:28:41 INFO - ##### 05:28:41 INFO - Running pre-action listener: _resource_record_pre_action 05:28:41 INFO - Running main action method: clobber 05:28:41 INFO - rmtree: /builds/slave/test/build 05:28:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:28:41 INFO - Running post-action listener: _resource_record_post_action 05:28:41 INFO - ##### 05:28:41 INFO - ##### Finished clobber step (success) 05:28:41 INFO - ##### 05:28:41 INFO - ##### 05:28:41 INFO - ##### Running read-buildbot-config step. 05:28:41 INFO - ##### 05:28:41 INFO - Running pre-action listener: _resource_record_pre_action 05:28:41 INFO - Running main action method: read_buildbot_config 05:28:41 INFO - Using buildbot properties: 05:28:41 INFO - { 05:28:41 INFO - "project": "", 05:28:41 INFO - "product": "firefox", 05:28:41 INFO - "script_repo_revision": "production", 05:28:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:28:41 INFO - "repository": "", 05:28:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:28:41 INFO - "buildid": "20160510044311", 05:28:41 INFO - "pgo_build": "False", 05:28:41 INFO - "basedir": "/builds/slave/test", 05:28:41 INFO - "buildnumber": 1253, 05:28:41 INFO - "slavename": "talos-linux64-ix-044", 05:28:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:28:41 INFO - "platform": "ubuntu64_hw", 05:28:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:28:41 INFO - "branch": "fx-team", 05:28:41 INFO - "repo_path": "integration/fx-team", 05:28:41 INFO - "revision": "2f9351bae69d056e4615d21dda6bf42fec5d16b7", 05:28:41 INFO - "stage_platform": "linux64", 05:28:41 INFO - "builduid": "5be4e77192d14761bc6040da40f2aee3", 05:28:41 INFO - "slavebuilddir": "test" 05:28:41 INFO - } 05:28:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:28:41 INFO - Running post-action listener: _resource_record_post_action 05:28:41 INFO - ##### 05:28:41 INFO - ##### Finished read-buildbot-config step (success) 05:28:41 INFO - ##### 05:28:41 INFO - ##### 05:28:41 INFO - ##### Running download-and-extract step. 05:28:41 INFO - ##### 05:28:41 INFO - Running pre-action listener: _resource_record_pre_action 05:28:41 INFO - Running main action method: download_and_extract 05:28:41 INFO - mkdir: /builds/slave/test/build/tests 05:28:41 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')]} 05:28:41 INFO - https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:28:42 INFO - Downloaded 1361 bytes. 05:28:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:28:42 INFO - Using the following test package requirements: 05:28:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:28:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:28:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:28:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'jsshell-linux-x86_64.zip'], 05:28:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:28:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:28:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:28:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:28:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:28:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:28:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:42 INFO - https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:28:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:43 INFO - Downloaded 22325904 bytes. 05:28:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:28:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:28:44 INFO - Return code: 0 05:28:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:28:44 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')]} 05:28:44 INFO - https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:28:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:28:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:45 INFO - Downloaded 22325904 bytes. 05:28:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:28:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:28:47 INFO - Return code: 0 05:28: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')]} 05:28:47 INFO - https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:28:48 INFO - Downloaded 10840152 bytes. 05:28:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:28:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:28:48 INFO - Return code: 0 05:28:48 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')]} 05:28:48 INFO - https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:28:49 INFO - Downloaded 54679710 bytes. 05:28:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:28:49 INFO - mkdir: /builds/slave/test/properties 05:28:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:49 INFO - Contents: 05:28:49 INFO - build_url:https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:28:50 INFO - Running post-action listener: _resource_record_post_action 05:28:50 INFO - Running post-action listener: set_extra_try_arguments 05:28:50 INFO - ##### 05:28:50 INFO - ##### Finished download-and-extract step (success) 05:28:50 INFO - ##### 05:28:50 INFO - ##### 05:28:50 INFO - ##### Running populate-webroot step. 05:28:50 INFO - ##### 05:28:50 INFO - Running pre-action listener: _resource_record_pre_action 05:28:50 INFO - Running main action method: populate_webroot 05:28:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:50 INFO - '--tppagecycles', 05:28:50 INFO - '7'], 05:28:50 INFO - 'tests': ['tsvgm']}}, 05:28:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['damp', 'tps']}, 05:28:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'tests': ['damp', 'tps']}, 05:28:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['dromaeo_dom']}, 05:28:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['a11yr', 05:28:50 INFO - 'ts_paint', 05:28:50 INFO - 'tpaint', 05:28:50 INFO - 'sessionrestore', 05:28:50 INFO - 'sessionrestore_no_auto_restore', 05:28:50 INFO - 'tabpaint']}, 05:28:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['tsvgx', 05:28:50 INFO - 'tsvgr_opacity', 05:28:50 INFO - 'tart', 05:28:50 INFO - 'tscrollx', 05:28:50 INFO - 'cart']}, 05:28:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:50 INFO - 'tsvgr_opacity', 05:28:50 INFO - 'tart', 05:28:50 INFO - 'tscrollx', 05:28:50 INFO - 'cart']}, 05:28:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'talos_options': ['--disable-e10s'], 05:28:50 INFO - 'tests': ['tp5o']}, 05:28:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'tests': ['tp5o']}, 05:28:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'talos_options': ['--disable-e10s', 05:28:50 INFO - '--xperf_path', 05:28:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:50 INFO - 'tests': ['tp5n']}, 05:28:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:50 INFO - 'talos_options': ['--xperf_path', 05:28:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:50 INFO - 'tests': ['tp5n']}}, 05:28:50 INFO - 'talos.zip': {'path': '', 05:28:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:50 INFO - Running post-action listener: _resource_record_post_action 05:28:50 INFO - ##### 05:28:50 INFO - ##### Finished populate-webroot step (success) 05:28:50 INFO - ##### 05:28:50 INFO - ##### 05:28:50 INFO - ##### Running create-virtualenv step. 05:28:50 INFO - ##### 05:28:50 INFO - Running pre-action listener: _resource_record_pre_action 05:28:50 INFO - Running main action method: create_virtualenv 05:28:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:50 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 05:28:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:50 INFO - Using real prefix '/usr' 05:28:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:52 INFO - Installing pip.................done. 05:28:52 INFO - Return code: 0 05:28:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:52 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:28:52 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 05:28:52 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 05:28:52 INFO - Using env: {'DISPLAY': ':0', 05:28:52 INFO - 'HOME': '/home/cltbld', 05:28:52 INFO - 'LANG': 'en_US.UTF-8', 05:28:52 INFO - 'LANGUAGE': 'en_US:en', 05:28:52 INFO - 'LOGNAME': 'cltbld', 05:28:52 INFO - 'MAIL': '/var/mail/cltbld', 05:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:52 INFO - 'MOZ_NO_REMOTE': '1', 05:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:52 INFO - 'NO_EM_RESTART': '1', 05:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:52 INFO - 'PWD': '/builds/slave/test', 05:28:52 INFO - 'SHELL': '/bin/bash', 05:28:52 INFO - 'SHLVL': '1', 05:28:52 INFO - 'TERM': 'linux', 05:28:52 INFO - 'TMOUT': '86400', 05:28:52 INFO - 'USER': 'cltbld', 05:28:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:52 INFO - '_': '/tools/buildbot/bin/python'} 05:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:53 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 05:28:53 INFO - Cleaning up... 05:28:53 INFO - Return code: 0 05:28:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:28:53 INFO - Using env: {'DISPLAY': ':0', 05:28:53 INFO - 'HOME': '/home/cltbld', 05:28:53 INFO - 'LANG': 'en_US.UTF-8', 05:28:53 INFO - 'LANGUAGE': 'en_US:en', 05:28:53 INFO - 'LOGNAME': 'cltbld', 05:28:53 INFO - 'MAIL': '/var/mail/cltbld', 05:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:53 INFO - 'MOZ_NO_REMOTE': '1', 05:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:53 INFO - 'NO_EM_RESTART': '1', 05:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:53 INFO - 'PWD': '/builds/slave/test', 05:28:53 INFO - 'SHELL': '/bin/bash', 05:28:53 INFO - 'SHLVL': '1', 05:28:53 INFO - 'TERM': 'linux', 05:28:53 INFO - 'TMOUT': '86400', 05:28:53 INFO - 'USER': 'cltbld', 05:28:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:53 INFO - '_': '/tools/buildbot/bin/python'} 05:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:53 INFO - Downloading/unpacking psutil>=0.7.1 05:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:55 INFO - Installing collected packages: psutil 05:28:55 INFO - Running setup.py install for psutil 05:28:55 INFO - building 'psutil._psutil_linux' extension 05:28:55 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 05:28:55 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 05:28:55 INFO - building 'psutil._psutil_posix' extension 05:28:55 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 05:28:55 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 05:28:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:55 INFO - Successfully installed psutil 05:28:55 INFO - Cleaning up... 05:28:55 INFO - Return code: 0 05:28:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:28:55 INFO - Using env: {'DISPLAY': ':0', 05:28:55 INFO - 'HOME': '/home/cltbld', 05:28:55 INFO - 'LANG': 'en_US.UTF-8', 05:28:55 INFO - 'LANGUAGE': 'en_US:en', 05:28:55 INFO - 'LOGNAME': 'cltbld', 05:28:55 INFO - 'MAIL': '/var/mail/cltbld', 05:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:55 INFO - 'MOZ_NO_REMOTE': '1', 05:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:55 INFO - 'NO_EM_RESTART': '1', 05:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:55 INFO - 'PWD': '/builds/slave/test', 05:28:55 INFO - 'SHELL': '/bin/bash', 05:28:55 INFO - 'SHLVL': '1', 05:28:55 INFO - 'TERM': 'linux', 05:28:55 INFO - 'TMOUT': '86400', 05:28:55 INFO - 'USER': 'cltbld', 05:28:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:55 INFO - '_': '/tools/buildbot/bin/python'} 05:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:28:58 INFO - Installing collected packages: mozsystemmonitor 05:28:58 INFO - Running setup.py install for mozsystemmonitor 05:28:58 INFO - Successfully installed mozsystemmonitor 05:28:58 INFO - Cleaning up... 05:28:58 INFO - Return code: 0 05:28:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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', '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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:28: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 blobuploader==1.2.4 05:28:58 INFO - Using env: {'DISPLAY': ':0', 05:28:58 INFO - 'HOME': '/home/cltbld', 05:28:58 INFO - 'LANG': 'en_US.UTF-8', 05:28:58 INFO - 'LANGUAGE': 'en_US:en', 05:28:58 INFO - 'LOGNAME': 'cltbld', 05:28:58 INFO - 'MAIL': '/var/mail/cltbld', 05:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:58 INFO - 'MOZ_NO_REMOTE': '1', 05:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:58 INFO - 'NO_EM_RESTART': '1', 05:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:58 INFO - 'PWD': '/builds/slave/test', 05:28:58 INFO - 'SHELL': '/bin/bash', 05:28:58 INFO - 'SHLVL': '1', 05:28:58 INFO - 'TERM': 'linux', 05:28:58 INFO - 'TMOUT': '86400', 05:28:58 INFO - 'USER': 'cltbld', 05:28:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:58 INFO - '_': '/tools/buildbot/bin/python'} 05:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:28: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 05:29:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 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 05:29:00 INFO - Downloading docopt-0.6.1.tar.gz 05:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:01 INFO - Running setup.py install for blobuploader 05:29:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:01 INFO - Running setup.py install for requests 05:29:01 INFO - Running setup.py install for docopt 05:29:01 INFO - Successfully installed blobuploader requests docopt 05:29:01 INFO - Cleaning up... 05:29:01 INFO - Return code: 0 05:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:29:01 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 05:29:01 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 05:29:01 INFO - Using env: {'DISPLAY': ':0', 05:29:01 INFO - 'HOME': '/home/cltbld', 05:29:01 INFO - 'LANG': 'en_US.UTF-8', 05:29:01 INFO - 'LANGUAGE': 'en_US:en', 05:29:01 INFO - 'LOGNAME': 'cltbld', 05:29:01 INFO - 'MAIL': '/var/mail/cltbld', 05:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:01 INFO - 'MOZ_NO_REMOTE': '1', 05:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:01 INFO - 'NO_EM_RESTART': '1', 05:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:01 INFO - 'PWD': '/builds/slave/test', 05:29:01 INFO - 'SHELL': '/bin/bash', 05:29:01 INFO - 'SHLVL': '1', 05:29:01 INFO - 'TERM': 'linux', 05:29:01 INFO - 'TMOUT': '86400', 05:29:01 INFO - 'USER': 'cltbld', 05:29:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:01 INFO - '_': '/tools/buildbot/bin/python'} 05:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:01 INFO - Running setup.py (path:/tmp/pip-upQMgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:01 INFO - Running setup.py (path:/tmp/pip-WM299w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:01 INFO - Running setup.py (path:/tmp/pip-tXxem0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:02 INFO - Running setup.py (path:/tmp/pip-_QW9aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:02 INFO - Running setup.py (path:/tmp/pip-OKoRwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:02 INFO - Running setup.py (path:/tmp/pip-S85YAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:02 INFO - Running setup.py (path:/tmp/pip-roXsMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:02 INFO - Running setup.py (path:/tmp/pip-McjmiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:02 INFO - Running setup.py (path:/tmp/pip-cSN6cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:02 INFO - Running setup.py (path:/tmp/pip-V1hLKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:02 INFO - Running setup.py (path:/tmp/pip-Qsgq9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:02 INFO - Running setup.py (path:/tmp/pip-GypM2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:02 INFO - Running setup.py (path:/tmp/pip-ZIJTpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:02 INFO - Running setup.py (path:/tmp/pip-LVdkPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:02 INFO - Running setup.py (path:/tmp/pip-7FUevE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:02 INFO - Running setup.py (path:/tmp/pip-FUY_12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:02 INFO - Running setup.py (path:/tmp/pip-6S7QZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:03 INFO - Running setup.py install for manifestparser 05:29:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Running setup.py install for mozcrash 05:29:03 INFO - Running setup.py install for mozdebug 05:29:03 INFO - Running setup.py install for mozdevice 05:29:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Running setup.py install for mozfile 05:29:03 INFO - Running setup.py install for mozhttpd 05:29:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Running setup.py install for mozinfo 05:29:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Running setup.py install for mozInstall 05:29:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:03 INFO - Running setup.py install for mozleak 05:29:03 INFO - Running setup.py install for mozlog 05:29:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Running setup.py install for moznetwork 05:29:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Running setup.py install for mozprocess 05:29:04 INFO - Running setup.py install for mozprofile 05:29:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Running setup.py install for mozrunner 05:29:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Running setup.py install for mozscreenshot 05:29:04 INFO - Running setup.py install for moztest 05:29:04 INFO - Running setup.py install for mozversion 05:29:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:04 INFO - Cleaning up... 05:29:04 INFO - Return code: 0 05:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:04 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:29:04 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 05:29:04 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 05:29:04 INFO - Using env: {'DISPLAY': ':0', 05:29:04 INFO - 'HOME': '/home/cltbld', 05:29:04 INFO - 'LANG': 'en_US.UTF-8', 05:29:04 INFO - 'LANGUAGE': 'en_US:en', 05:29:04 INFO - 'LOGNAME': 'cltbld', 05:29:04 INFO - 'MAIL': '/var/mail/cltbld', 05:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:04 INFO - 'MOZ_NO_REMOTE': '1', 05:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:04 INFO - 'NO_EM_RESTART': '1', 05:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:04 INFO - 'PWD': '/builds/slave/test', 05:29:04 INFO - 'SHELL': '/bin/bash', 05:29:04 INFO - 'SHLVL': '1', 05:29:04 INFO - 'TERM': 'linux', 05:29:04 INFO - 'TMOUT': '86400', 05:29:04 INFO - 'USER': 'cltbld', 05:29:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:04 INFO - '_': '/tools/buildbot/bin/python'} 05:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:05 INFO - Running setup.py (path:/tmp/pip-kdJlh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:05 INFO - Running setup.py (path:/tmp/pip-oCDRJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:05 INFO - Running setup.py (path:/tmp/pip-eqIWkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:05 INFO - Running setup.py (path:/tmp/pip-YRDqWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:05 INFO - Running setup.py (path:/tmp/pip-amXWCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:05 INFO - Running setup.py (path:/tmp/pip-p16CBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:05 INFO - Running setup.py (path:/tmp/pip-P1gdqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:05 INFO - Running setup.py (path:/tmp/pip-5ez4Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:05 INFO - Running setup.py (path:/tmp/pip-dkE6nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:05 INFO - Running setup.py (path:/tmp/pip-umBXwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:05 INFO - Running setup.py (path:/tmp/pip-b302HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:05 INFO - Running setup.py (path:/tmp/pip-dO2diU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:05 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)) 05:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:05 INFO - Running setup.py (path:/tmp/pip-7lF6ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:06 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)) 05:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:06 INFO - Running setup.py (path:/tmp/pip-TBxVsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:06 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)) 05:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:06 INFO - Running setup.py (path:/tmp/pip-GoV1Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:06 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)) 05:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:06 INFO - Running setup.py (path:/tmp/pip-WcocvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:06 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)) 05:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:06 INFO - Running setup.py (path:/tmp/pip-lSS7TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:06 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)) 05:29:06 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)) 05:29:06 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)) 05:29:06 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)) 05:29:06 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)) 05:29:06 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)) 05:29:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:08 INFO - Downloading blessings-1.6.tar.gz 05:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:08 INFO - Installing collected packages: blessings 05:29:08 INFO - Running setup.py install for blessings 05:29:08 INFO - Successfully installed blessings 05:29:08 INFO - Cleaning up... 05:29:08 INFO - Return code: 0 05:29:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:08 INFO - Reading from file tmpfile_stdout 05:29:08 INFO - Current package versions: 05:29:08 INFO - argparse == 1.2.1 05:29:08 INFO - blessings == 1.6 05:29:08 INFO - blobuploader == 1.2.4 05:29:08 INFO - docopt == 0.6.1 05:29:08 INFO - manifestparser == 1.1 05:29:08 INFO - mozInstall == 1.12 05:29:08 INFO - mozcrash == 0.17 05:29:08 INFO - mozdebug == 0.1 05:29:08 INFO - mozdevice == 0.48 05:29:08 INFO - mozfile == 1.2 05:29:08 INFO - mozhttpd == 0.7 05:29:08 INFO - mozinfo == 0.9 05:29:08 INFO - mozleak == 0.1 05:29:08 INFO - mozlog == 3.1 05:29:08 INFO - moznetwork == 0.27 05:29:08 INFO - mozprocess == 0.22 05:29:08 INFO - mozprofile == 0.28 05:29:08 INFO - mozrunner == 6.11 05:29:08 INFO - mozscreenshot == 0.1 05:29:08 INFO - mozsystemmonitor == 0.0 05:29:08 INFO - moztest == 0.7 05:29:08 INFO - mozversion == 1.4 05:29:08 INFO - psutil == 3.1.1 05:29:08 INFO - requests == 1.2.3 05:29:08 INFO - wsgiref == 0.1.2 05:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:08 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')]} 05:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:08 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')]} 05:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:08 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:29:08 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 05:29:08 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 05:29:08 INFO - Using env: {'DISPLAY': ':0', 05:29:08 INFO - 'HOME': '/home/cltbld', 05:29:08 INFO - 'LANG': 'en_US.UTF-8', 05:29:08 INFO - 'LANGUAGE': 'en_US:en', 05:29:08 INFO - 'LOGNAME': 'cltbld', 05:29:08 INFO - 'MAIL': '/var/mail/cltbld', 05:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:08 INFO - 'MOZ_NO_REMOTE': '1', 05:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:08 INFO - 'NO_EM_RESTART': '1', 05:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:08 INFO - 'PWD': '/builds/slave/test', 05:29:08 INFO - 'SHELL': '/bin/bash', 05:29:08 INFO - 'SHLVL': '1', 05:29:08 INFO - 'TERM': 'linux', 05:29:08 INFO - 'TMOUT': '86400', 05:29:08 INFO - 'USER': 'cltbld', 05:29:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:08 INFO - '_': '/tools/buildbot/bin/python'} 05:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 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)) 05:29:08 INFO - Cleaning up... 05:29:08 INFO - Return code: 0 05:29:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29:08 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')]} 05:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:08 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')]} 05:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:08 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:29:08 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 05:29:08 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 05:29:08 INFO - Using env: {'DISPLAY': ':0', 05:29:08 INFO - 'HOME': '/home/cltbld', 05:29:08 INFO - 'LANG': 'en_US.UTF-8', 05:29:08 INFO - 'LANGUAGE': 'en_US:en', 05:29:08 INFO - 'LOGNAME': 'cltbld', 05:29:08 INFO - 'MAIL': '/var/mail/cltbld', 05:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:08 INFO - 'MOZ_NO_REMOTE': '1', 05:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:08 INFO - 'NO_EM_RESTART': '1', 05:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:08 INFO - 'PWD': '/builds/slave/test', 05:29:08 INFO - 'SHELL': '/bin/bash', 05:29:08 INFO - 'SHLVL': '1', 05:29:08 INFO - 'TERM': 'linux', 05:29:08 INFO - 'TMOUT': '86400', 05:29:08 INFO - 'USER': 'cltbld', 05:29:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:08 INFO - '_': '/tools/buildbot/bin/python'} 05:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:09 INFO - Downloading/unpacking jsonschema 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 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 05:29:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:10 INFO - Downloading/unpacking functools32 (from jsonschema) 05:29:10 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 05:29:10 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 05:29:10 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 05:29:10 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 05:29:10 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 05:29:10 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 05:29:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:11 INFO - warning: no files found matching '*.txt' 05:29:11 INFO - no previously-included directories found matching 'build' 05:29:11 INFO - no previously-included directories found matching 'dist' 05:29:11 INFO - no previously-included directories found matching '.git*' 05:29:11 INFO - Installing collected packages: jsonschema, functools32 05:29:11 INFO - Running setup.py install for functools32 05:29:11 INFO - warning: no files found matching '*.txt' 05:29:11 INFO - no previously-included directories found matching 'build' 05:29:11 INFO - no previously-included directories found matching 'dist' 05:29:11 INFO - no previously-included directories found matching '.git*' 05:29:11 INFO - Successfully installed jsonschema functools32 05:29:11 INFO - Cleaning up... 05:29:11 INFO - Return code: 0 05:29:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:11 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 0x7f2280deef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, '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': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', '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 05:29:11 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 05:29:11 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 05:29:11 INFO - Using env: {'DISPLAY': ':0', 05:29:11 INFO - 'HOME': '/home/cltbld', 05:29:11 INFO - 'LANG': 'en_US.UTF-8', 05:29:11 INFO - 'LANGUAGE': 'en_US:en', 05:29:11 INFO - 'LOGNAME': 'cltbld', 05:29:11 INFO - 'MAIL': '/var/mail/cltbld', 05:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:11 INFO - 'MOZ_NO_REMOTE': '1', 05:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:11 INFO - 'NO_EM_RESTART': '1', 05:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:11 INFO - 'PWD': '/builds/slave/test', 05:29:11 INFO - 'SHELL': '/bin/bash', 05:29:11 INFO - 'SHLVL': '1', 05:29:11 INFO - 'TERM': 'linux', 05:29:11 INFO - 'TMOUT': '86400', 05:29:11 INFO - 'USER': 'cltbld', 05:29:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:11 INFO - '_': '/tools/buildbot/bin/python'} 05:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:11 INFO - Downloading/unpacking flake8 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29: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 05:29:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:29:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:29:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:13 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 05:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:14 INFO - no previously-included directories found matching 'docs/_build' 05:29:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:29:14 INFO - Running setup.py install for pep8 05:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:14 INFO - no previously-included directories found matching 'docs/_build' 05:29:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:29:14 INFO - Cleaning up... 05:29:14 INFO - Return code: 0 05:29:14 INFO - Running post-action listener: _resource_record_post_action 05:29:14 INFO - Running post-action listener: _start_resource_monitoring 05:29:14 INFO - Starting resource monitoring. 05:29:14 INFO - ##### 05:29:14 INFO - ##### Finished create-virtualenv step (success) 05:29:14 INFO - ##### 05:29:14 INFO - ##### 05:29:14 INFO - ##### Running install step. 05:29:14 INFO - ##### 05:29:14 INFO - Running pre-action listener: _resource_record_pre_action 05:29:14 INFO - Running main action method: install 05:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:14 INFO - Reading from file tmpfile_stdout 05:29:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:14 INFO - Reading from file tmpfile_stdout 05:29:14 INFO - Output received: 05:29:14 INFO - Usage: mozinstall [options] installer 05:29:14 INFO - Options: 05:29:14 INFO - -h, --help show this help message and exit 05:29:14 INFO - -d DEST, --destination=DEST 05:29:14 INFO - Directory to install application into. [default: 05:29:14 INFO - "/builds/slave/test"] 05:29:14 INFO - --app=APP Application being installed. [default: firefox] 05:29:14 INFO - mkdir: /builds/slave/test/build/application 05:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:29:30 INFO - Reading from file tmpfile_stdout 05:29:30 INFO - Output received: 05:29:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:29:30 INFO - Running post-action listener: _resource_record_post_action 05:29:30 INFO - ##### 05:29:30 INFO - ##### Finished install step (success) 05:29:30 INFO - ##### 05:29:30 INFO - ##### 05:29:30 INFO - ##### Running run-tests step. 05:29:30 INFO - ##### 05:29:30 INFO - Running pre-action listener: _resource_record_pre_action 05:29:30 INFO - Running main action method: run_tests 05:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:30 INFO - Python 2.7.3 05:29:30 INFO - Return code: 0 05:29:30 INFO - grabbing minidump binary from tooltool 05:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:30 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 0x2ac69c0>, '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 0x2ac78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:30 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 05:29:30 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 05:29:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:30 INFO - Return code: 0 05:29:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:29:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:29:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:29:31 INFO - Return code: 0 05:29:31 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/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:29:31 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/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:29:31 INFO - Using env: {'DISPLAY': ':0', 05:29:31 INFO - 'HOME': '/home/cltbld', 05:29:31 INFO - 'LANG': 'en_US.UTF-8', 05:29:31 INFO - 'LANGUAGE': 'en_US:en', 05:29:31 INFO - 'LOGNAME': 'cltbld', 05:29:31 INFO - 'MAIL': '/var/mail/cltbld', 05:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:31 INFO - 'MOZ_NO_REMOTE': '1', 05:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:31 INFO - 'NO_EM_RESTART': '1', 05:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:31 INFO - 'PWD': '/builds/slave/test', 05:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:31 INFO - 'SHELL': '/bin/bash', 05:29:31 INFO - 'SHLVL': '1', 05:29:31 INFO - 'TERM': 'linux', 05:29:31 INFO - 'TMOUT': '86400', 05:29:31 INFO - 'USER': 'cltbld', 05:29:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947', 05:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:31 INFO - '_': '/tools/buildbot/bin/python'} 05:29:31 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/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:29:31 INFO - mozversion application_buildid: 20160510044311 05:29:31 INFO - mozversion application_changeset: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 05:29:31 INFO - mozversion application_display_name: Nightly 05:29:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:31 INFO - mozversion application_name: Firefox 05:29:31 INFO - mozversion application_remotingname: firefox 05:29:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:29:31 INFO - mozversion application_vendor: Mozilla 05:29:31 INFO - mozversion application_version: 49.0a1 05:29:31 INFO - mozversion platform_buildid: 20160510044311 05:29:31 INFO - mozversion platform_changeset: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 05:29:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:29:31 INFO - mozversion platform_version: 49.0a1 05:29:31 INFO - using testdate: 1462883371 05:29:31 INFO - actual date: 1462883371 05:29:31 INFO - starting webserver on 'localhost:37056' 05:29:31 INFO - SUITE-START | Running 2 tests 05:29:31 INFO - TEST-START | dromaeo_css 05:29:31 INFO - operating with platform_type : linux_ 05:29:31 INFO - Initialising browser for dromaeo_css test... 05:29:31 INFO - TEST-INFO | started process 30509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVppJT/profile http://localhost:37056/getInfo.html) 05:29:35 INFO - PROCESS | 30509 | 05:29:35 INFO - PROCESS | 30509 | (process:30576): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:36 INFO - PROCESS | 30509 | __metrics Screen width/height:1600/1200 05:29:36 INFO - PROCESS | 30509 | colorDepth:24 05:29:36 INFO - PROCESS | 30509 | Browser inner width/height: 1024/697 05:29:36 INFO - PROCESS | 30509 | __metrics 05:29:37 ERROR - PROCESS | 30509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:29:38 INFO - TEST-INFO | 30509: exit 0 05:29:38 INFO - Browser initialized. 05:29:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:38 INFO - TEST-INFO | started process 30627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVppJT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:40 INFO - PROCESS | 30627 | 05:29:40 INFO - PROCESS | 30627 | (process:30686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:50 INFO - PROCESS | 30627 | RSS: Main: 164306944 05:29:50 INFO - PROCESS | 30627 | 05:30:39 INFO - PROCESS | 30627 | 1462883439757 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] 05:32:51 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37056/tests/dromaeo/cssquery-ext.html) 05:32:52 INFO - PROCESS | 30627 | RSS: Main: 165933056 05:32:52 INFO - PROCESS | 30627 | 05:35:54 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-ext.html (next: http://localhost:37056/tests/dromaeo/cssquery-jquery.html) 05:35:55 INFO - PROCESS | 30627 | RSS: Main: 166670336 05:35:55 INFO - PROCESS | 30627 | 05:38:57 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37056/tests/dromaeo/cssquery-mootools.html) 05:38:57 INFO - PROCESS | 30627 | RSS: Main: 167788544 05:38:57 INFO - PROCESS | 30627 | 05:41:59 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37056/tests/dromaeo/cssquery-prototype.html) 05:42:00 INFO - PROCESS | 30627 | RSS: Main: 165859328 05:42:00 INFO - PROCESS | 30627 | 05:45:03 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37056/tests/dromaeo/cssquery-yui.html) 05:45:03 INFO - PROCESS | 30627 | RSS: Main: 166846464 05:45:03 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | Cycle 1(1): loaded http://localhost:37056/tests/dromaeo/cssquery-yui.html (next: http://localhost:37056/tests/dromaeo/cssquery-dojo.html) 05:48:06 INFO - PROCESS | 30627 | RSS: Main: 168513536 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | __start_tp_report 05:48:06 INFO - PROCESS | 30627 | _x_x_mozilla_page_load 05:48:06 INFO - PROCESS | 30627 | _x_x_mozilla_page_load_details 05:48:06 INFO - PROCESS | 30627 | |i|pagename|runs| 05:48:06 INFO - PROCESS | 30627 | |0;dojo.html;2650.8011899107564;2698.082651898354;2710.2004908551976;2717.171262764857;2734.412101398199;4748.596369308609;4838;4872.75636218189;4884.658073934826;4956.900861982758;4714.882127946803;4813.56677898989;4841.491643377448;4856.465788763242;4887.706737595747;4405.889852753683;4434.623057040156;4539.137563862872;4546.47715512717;4562.315652652095;631.9196641469614;4162.854300099497;4377.365282034103;4394.362817391477;4477.977610111945;4366.279563871942;4403.801828917706;4405.933910991338;4422.911541769179;4423.491298500681;4397.252467080604;4415.337699345124;4416.1609294233995;4417.403650507173;4460.375547423363;4353.259945809188;4405.876501492131;4407;4410.823567057314;4425.5353187915125;4716.221823399135;4740.312654665088;4752.52474752522;4759.904801903977;4769.070031343855;4977.875553111201;5046.798128074873;5155.32980712505;5173.870653233662;5187.584993200535;5066.847994560169;5101.744912754348;5148.459411761749;5148.536631703165;5178.40448348441;4772.069446457942;4854.296127061556;4865.5864251539015;4879.682820616648;4917.975410122998;5265.947340526545;5281.656692314988;5345.1714984177515;5355.143177091724;5355.518003379714;5096.108181068298;5132.79468821243;5139.074966506065;5141.511556402136;5142.5628821549835;5210.400803907523;5221.138512145453;5221.425643179247;5222.634415590872;5247.317848679647;4980.352554167935;5140.1004824155625;5177.378714554277;5220.216967454912;5243.580513558906;5149.948500515022;5171.095058364771;5177.4822517747925;5203.973980130075;5248.186531087687;4334.176506463762;4463.928657122267;4497.257952437811;4512;4559.566841150086;3775.565809931838;3798.810059497014;3849.9037524062123;3853.0560012797046;3888.3389823730035;4462.642988560908;4502.234620114523;4515.367848501212;4547.295169248771;4584.862454126382;5258.789648414021;5265.710385928811;5279.41926388097;5280.234366016906;5285.709285989307;4429.889252768642;4443.600075993176;4479.484859241164;4494.9325760113625;4502.4371953505815;4682.508336624674;4730.59789917854;4731.668783185144;4734.19518681825;4777.283407488904;4728.905421891612;4890.168671325883;4892.730899800403;4916;4946.802127914915;5216.452272511332;5274.182501712241;5294.470552944675;5299.788008479618;5347.679139251657;4793.784279707352;4823.782929768098;4828.565429111397;4833.879153021203;4881.194602890625;4958.380202474691;5104.821331253388;5113.974430127825;5116.360454943132;5133.820316288912;5113.463086375877;5173.767180476812;5205.505476979681;5210.921836172536;5212;5047.116754568009;5077.8730531737;5089.720065396439;5092.745362731923;5141.074606570854;4848.61211103118;5060.595152387874;5084.720340381315;5091.974540127276;5097.847064588068;4996.125678006407;5020.949790502048;5067.493250674903;5087.3386459759995;5128.333316668958;5182.689038657692;5188.351456067991;5193.558547523352;5198.8177731415335;5247.1079916415065;4809.903801923872;4951.925721114114;4960.751962401793;5081.593472522263;5092.210707340369 05:48:06 INFO - PROCESS | 30627 | |1;ext.html;572.513363640905;605.2857627998962;609.1259043272904;621.2327775197632;639.7249182851372;38758.22483550327;43133.35299970503;43153;43222;43410.565894341045;43958.340624890654;44598.33102503465;44688;44694.55305446945;44827.77586112073;7924.44528882977;8056.798580035516;8060.637271322805;8091.838163236732;8098.554579498125;7946.443748937577;7970.481918675297;8006.759797206064;8016.438849280553;8042.356611471068;7829.608519574027;7857.607119644023;7865.4887432317;7873.173316801739;7873.291403773688;7998.200179981985;8002.639881205359;8004.559749213791;8004.799880002988;8022.478538894982;7938.285554300083;7984.600769961537;7988.121306656321;7988.920110798876;8007.839843203162;31448;40384.79807600943;40848.387274190914;40904.79547602273;41155.794221029006;2930.9009121579406;2957.837318947457;3004.8347340896244;3322.4185767490594;3403.2172600301824;28658.570121448196;28765.856170719013;28886.711132888824;29218.033113903894;29238.853805731047;3081.1988882890387;3081.5223640335785;3104.8292343921075;3124.9687503124906;3160.573322601442;219084;219948;219953.9999999984;220106;221221;34489;34555.481667775006;34596.65403345985;34611.653883461346;34629.480557791656;35794.28411431757;36164.819175903955;36933;37012.62987370092;39026.41460378097;16181.676366472604;16380;16486.917565412095;16497;16504.504864854072;12492.750144997231;12622.621321360373;12627;12642.304673242876;12654.873451265554;19812.20751169937;20262.088206030763;20393.286234981704;20408;20470.79529204689;7124.5725256484775;7507.099148102263;7537.283958023979;7566.546007239584;7723.189065148191;761.7981234972737;826.8553003224412;827.606886728811;872.7076429396224;888.6401007591936;28233.77140581458;29123.417531649247;29673.85163074214;29724.55413168804;29895.850520747255;1036.657902892059;1042.213129087534;1056.4612047855649;1101.9971825638631;1138.9031932285848;15429.922850385676;15555.611109722347;15654.530364089096;15911.602209944613;15963.600909977344;371515;485851;486851;495587;784170;54214.186787198225;54238;54599.727001365536;54683.45316546863;54877;1263.8988880889506;1266.9619911402672;1279.3731071774948;1304.0675916719401;1308.6662900960384;28800;30257.24356891095;30470.84764576163;30788.53440777462;31313.686863131075;45924.08151837011;46402.30396544122;46557.76721116373;46643.30035049409;46695.76652116718;353784;356496;358923;359551;359971;27071.86464067667;27493.86253068722;27545.035923742573;27634.861825691547;27662.44675106527;43655.78172109119;44260.336094959246;44592;44991;45513.544864552256;37745.24509509849;38057;38495.230095398496;38528.80735596304;38699.22601547897;36059.45910811392;37789.81105094457;38314.233715326096;38380.80809595934;38791;37078.8146059268;37169.81415093016;37235.255294894494;38086.61913380831;38109.80945095257;32562.348753024333;33452.330953381286;34264;34472.310553789284;34577.48133777945;25825.870870645525;25845.741542584332;25885.289272700196;26419.838982209138;26605.201843944713 05:48:06 INFO - PROCESS | 30627 | |2;jquery.html;381.7919234017459;391.5536288630961;392.4107562061686;398.18968399307397;408.9714368363566;16170.353185872566;16574;17405.738913916302;17476.912615436922;17526.561835954108;9633.229341652668;10093.243006774503;10537.789244215111;10538.209634277422;10576.78846423071;4659.4175728034;4779.330893674888;4781.760911954406;5320.228566857803;5458.153986132156;5388.91916621251;5397.2443857859935;5401.513863752261;5419.132938729804;5424.620276580641;4951.430585482662;4975.577075948549;5239.73801309933;5406.324209473816;5422.674639521641;4840.854774356775;4932.112219800452;4943.431505376891;4954.157793175169;4960.851174464772;4727.007328461027;4757.78589963449;4798.496157903405;4815.0610630926985;4894.657373983822;18149.637007259913;18169.273229070823;19222.423327300203;20416.795832041786;20662;1920.4910698664864;1931.6329897319604;1935.8741681790639;1957.530192753743;1982.7025946108056;9252.8612070819;9373.437593744397;9442.90557094434;9815.21478281743;9903.45530995795;1768.8408043276168;1860.0513737993585;1864.2915692036938;1874.55010797409;1933.3426634944187;66015;69379.65310173416;69421.65289173572;70327.99999999949;70877;10225.642102526375;10529.105026072717;10547.578096876192;10680.999999999845;10785.40680262593;14588.489402870848;14726.33731482086;14738.263086845614;14739.115653060851;14763.409463621334;6625.701843417058;7262.818429539198;7621.618919054025;7771.222877712296;8015.599220039091;7492.850142997109;7514.812129696801;7614.162442131361;7712.383009359238;7815.491993020435;4370.322599997005;4502.707324023928;4523.570260825217;4556.157110934488;4578.404807375086;1884.1992153334777;1902.3912348048768;1981.3362523554483;1987.7813440521531;2001.119507416732;853.99558586682;914.2503147419053;916.4867674102524;945.9810803783886;1062.6227689170387;10480.842787358195;10506.212034097472;10594.417307048187;10659.626913058006;10909.563617455213;443.59854331829104;449.17576247586044;455.3920516110963;459.27893207663647;463.1038939651785;5828.271466066742;6038.30559485656;6089.2997305310455;6139.846503837351;6195.2255968004;416201;418997;422454;423107;434110;81626.18373816185;81885;82122;84261.57869210615;84427;467.8175511550498;470.39554172887676;471.5567366675383;472.4802717011329;473.862579851846;10334.844977325196;10374.27380083387;10447;10505;10674.73313167177;29865.95469158569;34902.82548587241;35326;35572.466413004346;35952;39510.604893950695;44680.55319446764;45175;45201.773991129834;46635.76682116568;7798.727044553413;7948.364130869632;7966.960165199137;8067.596620168851;8150.796230094295;11673.941630291794;11696.122790790554;11717.355545445082;11753.823692644788;11826.172167948162;10640.52117654692;10654;10784.299020563638;10852;10857.077148442471;5201.7399130044105;10584.629537966443;10779.568817247537;10906.127509799038;10925;10566.524506397383;11012.119030477703;11058.723531911766;11125.165612578927;11207.49566269536;7875.763727088197;7898.091719452107;7949.244821741925;7976.521408715495;8179.836403271782;8049.637766300648;9769.511524423893;10687.25189236746;10872.945635271773;11166.218364714392 05:48:06 INFO - PROCESS | 30627 | |3;mootools.html;1390.0755997261817;1459.9270036498176;1596.6726821001696;1692.5599344170512;1872.8501719862404;6495.772647957322;7429.442791790624;7487.550746955179;7837.568933708644;7871.094824095231;7499.725046742054;7770.68917243311;7802;7803.960980195106;7822.374210063182;2222.1111555377856;2246.0903334149616;2246.33733048751;2254.222293308806;2256.187772401934;2200.3728937252886;2203.6584329428965;2264.547090581882;2265.399669087693;2266.9206577769783;2220.844540882139;2223.9777602224012;2226.532428190082;2227.287268074217;2248.067052173346;2120.300300900699;2147.076756994492;2151.3868547463976;2156.35309407178;2156.784321567831;2167.4689701023194;2182.9890850545803;2189.715337006195;2199.846010779246;2212.4800671842104;7786.649600767979;7793.688252469894;7831.216878312181;7848.450608457353;7859.96070019652;4667.766611669437;4779.474257831671;4789.760511974422;4830.9275360869615;4835.782389792468;2780.5134101532353;3036.6052413186367;3050.6339239291206;3063.2954420483193;3102.5811515445353;931.2177770672599;937.5452905340904;938.6057855700553;950.5579905344048;955.016333176829;10502.474876256156;10517.316374435637;10556.577736890515;10558.577656893714;10562.894371056267;4305.138972205571;4317.330813723878;4416.889577760582;4423.646108311392;4510.503844577094;9046.909530904606;9119.817603648022;9129.45223286605;9135.817283654422;9155.862662060075;4749.810007599726;4793.520647935178;4800.3759511263315;4818.951810481921;4820.060088282821;3672.944905826415;4235.53409124996;4257.27626303523;4353.390525326457;4371.956280437218;3607.2244467439627;3667.431548110047;3758.924821503609;3760.4359346098304;3842.2315536892734;1198.3469009389903;1203.7773011992808;1220.097128125181;1220.2922305063219;1229.9815502767465;737.4211244173298;760.125855266448;792.4175730837829;798.7923139983646;804.63389157933;4970.254461830755;5007.349044624249;5007.874803129951;5083.135866902636;5120.385553733501;418.9560096189917;428.05186511876343;430.984915527955;431.0903992575663;439.2159994409963;3402.897913062612;3418.5555877736233;3438.570178727659;3469.6356882527475;3493.633168517269;9286.535673216447;9389.765255868659;9710.951445242728;9719.854202186973;9730.805383892424;9466.668666596635;9487.857682134774;9508.857367139499;9603.807923841485;9655.22758179344;7231.602261875647;7277.726397880349;7285.344319011315;7303.160136584361;7312.634368281565;5028.547430731105;5089.821856235014;5135.6918584885025;5150.072986862401;5154.664946778447;8419.452735572168;8714.389992700704;8733.606987685442;8745.56272186401;8850.38047336706;8869.201771840566;8955.104489550993;9043.593038313424;9054.773630659287;9066.95466522663;5955.404459554184;6747.730090796314;6759.087523184307;6847.589144651337;6991.335823096798;7675.692972281046;7685.807854803675;7730.729424470116;7753.689852405841;7765.5728934906865;6623.635700036544;6813.829654258683;6834.965825171042;6868.828279293058;6888.0356750056035;6755.3582409671;6803.387695107464;6835.658217089225;6944.062551555678;7005.264447233171;6256.937430625636;6291.339409361951;6350.237971443272;6356.745730170742;6361.968190159019;4562.58936695699;4591.494935557019;4628.907421851612;4657.231556793226;4666.603338716247;4517.774111294357;4555.362249285036;4618.284165954283;4658.208104622155;4667 05:48:06 INFO - PROCESS | 30627 | |4;prototype.html;308.8918878392563;313.72549019607845;321.1281371077525;321.9002109346104;327.4286370283855;4819.277108433736;4935.457099719028;5024.221245706916;5035.924461133086;5083.18669012958;4882.145624515704;4903.9754801225945;4922.581580565657;5015.799368025284;5022.447530771612;3916.9608303916953;3923.1761330120707;3933.7639741615453;3938.1139243670086;3939;3652.5799533053773;3947.3881548359905;3948.644621984021;3962.2669806085823;3989.421533877586;3820.4269359596005;3838.500994870677;3838.539375274957;3839.289731399686;3840.596737342567;3834.8657796976972;3848.1726428817797;3864.942025869614;3871.5160604924386;3873.4189871519216;3403.3193361327585;3408.164999575095;3411.232472693649;3437.3984552703178;3439.4496880499;4578.473475550321;4751.1922973094315;4754.453237877654;4817.530653150788;4855.660103792736;4314.482262128533;4362.36745671879;4387.714798538085;4397.6587140922;4403.603675669173;5156.767945442464;5157.381114266312;5169.896602067975;5182.689038657692;5190.4047976012;3582.4089025311055;3691.2617476504806;3726.608706085849;3748.287825313209;3758.962410375889;5460.672359658433;5484.8354549363585;5487.862803429906;5488.53347465466;5492.81904390558;3818.293615681108;3821.5987321331418;3823.5411750590106;3826.4069069294305;3851.807409629507;3877.728559000899;3891.8248678809523;3893.3381325174787;3900.083480382108;3906.570277269498;4336.696431249846;4402.719004689142;4413.668974826901;4417.293233082692;4418.315161150027;5236.6334356595435;5242.370915490165;5248.396434410091;5271.551918087006;5285;1236.1285293867802;1284.4797856867983;1314.1589382795019;1327.9468821247042;1332.5136325241217;844.1389782421895;844.4553263145237;849.3205435651454;868.700298397052;875.8467268228035;3998.8203479973477;4000.6799456043445;4072.328065869158;4076.510818701775;4090.9590904091174;4631.9536804631525;4668.879468927433;4668.906621867543;4701.48283688794;4729.266963620576;4025.75845449274;4038.3538633819035;4040.575739547364;4062.837486500566;4071;2358.6462030695534;2532.3669082729316;2536.771690547823;2540.2125341143933;2557.974420255811;4447.822087116479;4476.865694029184;4484.686071974996;4497.910041799146;4519.6441067680225;4747.95252047482;4784.4497882743235;4786.473487916326;4866.197077482247;4899.657024008286;4261.850835220753;4298.76356800379;4459.888502787457;4501.617362524156;4510.2783554631105;4650.604818554352;4733.290006498915;4742.976285118552;4761.452432970114;4792.046561586774;4662.836800711959;4678.906421871611;4693.108309421199;4713.976430117965;4735.455422626442;4308.590683885026;4439.711418757771;4457.242268814244;4458.777061146865;4465.821367145278;3374.7300215983155;3434.3131373724855;3453.378391889484;3462.428699264593;3479.8434070466383;4637.768111594474;4701.224297990793;4707.340972263817;4708.387909571734;5155.484451554815;5070.771815268248;5194.922076168936;5218.712970786643;5224.477552244745;5234.18870075139;5163.586913046872;5172.456892026283;5186.521841275218;5199.55803756685;5227.634065615523;5021.297018417497;5080.26336181259;5113.130767769414;5120.923186152137;5152.922706159486;5232.790688372575;5243.659162154448;5253;5274.419813820554;5287.206918962032;5107.565856902205;5120.155174396332;5130.8973820524125;5145.665531740425;5171.172612382001 05:48:06 INFO - PROCESS | 30627 | |5;yui.html;709.2163159708525;732.9706811727531;760.8592410404076;773.4083426178975;773.8336257704594;11390.658280251586;11809.70475738107;12072.818907716392;12101.092418068647;12154.20997635153;11423.371714555697;11480.942595287033;11499.3100413975;11513.021393181589;11515.309081455098;685.4858855858106;860.5912191708951;866.9219770220678;873.9257163141109;882.6160620130264;865.7056600755742;866.8916385451819;874.8731433942074;875.1598465473154;877.9824403511958;907.2152588011355;909.9863502047475;910.4082346474811;911.8814554107956;913.0458670689146;902.0213068820306;907;907.0611916666285;912.16536868765;915.1397686174975;669.2738378858944;671.3957438305564;672.6972862212024;673.8012286375531;674.0428591400174;12883.227006379648;12899.161554499022;12901.612951611467;12928.676783080498;12955;12516.249025058525;12550.560730374484;12630;12641.367931603383;12710.271052040938;10352.171826253882;10428.687139385755;10431.21765867563;10460.68617941463;10619.94690026545;3301.950470742941;3397.8301084945656;3403.4724617684296;3426.9828650856584;3471.288385880888;47355.289670654965;47520.7623961878;48299.03401931977;48404.75797621025;48580.27129593024;10192.286539942133;10280.22898282617;10431.94784026075;10452.68641940743;10493.160547156209;15726.449574264845;16411.1794410279;16453.341866325212;16472;16532.173391330387;6388.552801303864;6539.378759017885;6852.074969879002;6862.9313706863295;7108.786736397813;3584.605693373727;3733.328000959799;3797.525309336333;3880.767153970771;3955.564887862333;2748.5464898291957;2804.7195280471788;2875.1230874583034;2878.309205790637;2889.3787835615444;495.38077403245944;502.1964856230003;513.609656660933;529.7827890564927;534.0653855752433;434.0845572932197;501.7390956702494;509.15480302697347;512.5976108754684;560.6243816642859;7633.809154771064;7635.847283054308;7662.693492260247;7860.921390786133;8271.2142346477;606.1483615520201;608.5162295974711;628.1174949196295;630.9558330916883;644.5230529408204;3369.5451114099283;3402.2515046689687;3572.8392222350058;3784.8675296364495;3986.86045988389;50267.24599131016;51971.74014129981;52121;54816.72591637016;55817.441825582035;34258.314833703684;45102.774486128015;45121.32318015232;46051.76974115108;46927;42287.365689514685;42658.786706066894;43047.35428968568;43348.99999999937;43822;7165.140183178052;7216.675249613675;7248.927510725036;7249.528780629243;7536.660850261642;28539.714602853706;29212.415751685272;29262.707372925997;29758.702412976458;30158.095257142322;36666.81666591757;37318;37819.62180378161;38037;38195;10535.42055186972;10680.946595267285;10738.892611074101;10755.623553175601;10868.67393978182;12039.458224379749;12321.199122057396;12347.814782778445;12385.009199263857;12454.626361209179;11539.624699437363;11623.418829058683;11639.41802909868;11693.707657308636;11846.940765296118;10982.615608453985;11350.94324528372;11623.59317423886;11646.88353116458;11732.12009099304;11373.772524549297;11474.885251147381;11862.881371186522;12006.09954253417;12008;9501.667441639509;9596.616135354509;9962.651307204213;10051.798964020532;10397.16822654201;9041.547922603711;9296.349255552046;9424.198943089914;9854.950725246616;9943.25425593069 05:48:06 INFO - PROCESS | 30627 | __end_tp_report 05:48:06 INFO - PROCESS | 30627 | __start_cc_report 05:48:06 INFO - PROCESS | 30627 | _x_x_mozilla_cycle_collect,371 05:48:06 INFO - PROCESS | 30627 | __end_cc_report 05:48:06 INFO - PROCESS | 30627 | __startTimestamp1462884486641__endTimestamp 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | ------- Summary: start ------- 05:48:06 INFO - PROCESS | 30627 | Number of tests: 6 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#0] dojo.html Cycles:165 Average:4773.13 Median:4916.00 stddev:605.83 (12.3%) stddev-sans-first:584.36 05:48:06 INFO - PROCESS | 30627 | Values: 2650.8 2698.1 2710.2 2717.2 2734.4 4748.6 4838.0 4872.8 4884.7 4956.9 4714.9 4813.6 4841.5 4856.5 4887.7 4405.9 4434.6 4539.1 4546.5 4562.3 631.9 4162.9 4377.4 4394.4 4478.0 4366.3 4403.8 4405.9 4422.9 4423.5 4397.3 4415.3 4416.2 4417.4 4460.4 4353.3 4405.9 4407.0 4410.8 4425.5 4716.2 4740.3 4752.5 4759.9 4769.1 4977.9 5046.8 5155.3 5173.9 5187.6 5066.8 5101.7 5148.5 5148.5 5178.4 4772.1 4854.3 4865.6 4879.7 4918.0 5265.9 5281.7 5345.2 5355.1 5355.5 5096.1 5132.8 5139.1 5141.5 5142.6 5210.4 5221.1 5221.4 5222.6 5247.3 4980.4 5140.1 5177.4 5220.2 5243.6 5149.9 5171.1 5177.5 5204.0 5248.2 4334.2 4463.9 4497.3 4512.0 4559.6 3775.6 3798.8 3849.9 3853.1 3888.3 4462.6 4502.2 4515.4 4547.3 4584.9 5258.8 5265.7 5279.4 5280.2 5285.7 4429.9 4443.6 4479.5 4494.9 4502.4 4682.5 4730.6 4731.7 4734.2 4777.3 4728.9 4890.2 4892.7 4916.0 4946.8 5216.5 5274.2 5294.5 5299.8 5347.7 4793.8 4823.8 4828.6 4833.9 4881.2 4958.4 5104.8 5114.0 5116.4 5133.8 5113.5 5173.8 5205.5 5210.9 5212.0 5047.1 5077.9 5089.7 5092.7 5141.1 4848.6 5060.6 5084.7 5092.0 5097.8 4996.1 5020.9 5067.5 5087.3 5128.3 5182.7 5188.4 5193.6 5198.8 5247.1 4809.9 4951.9 4960.8 5081.6 5092.2 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#1] ext.html Cycles:180 Average:51604.61 Median:37045.72 stddev:105817.72 (285.6%) stddev-sans-first:106045.20 05:48:06 INFO - PROCESS | 30627 | Values: 572.5 605.3 609.1 621.2 639.7 38758.2 43133.4 43153.0 43222.0 43410.6 43958.3 44598.3 44688.0 44694.6 44827.8 7924.4 8056.8 8060.6 8091.8 8098.6 7946.4 7970.5 8006.8 8016.4 8042.4 7829.6 7857.6 7865.5 7873.2 7873.3 7998.2 8002.6 8004.6 8004.8 8022.5 7938.3 7984.6 7988.1 7988.9 8007.8 31448.0 40384.8 40848.4 40904.8 41155.8 2930.9 2957.8 3004.8 3322.4 3403.2 28658.6 28765.9 28886.7 29218.0 29238.9 3081.2 3081.5 3104.8 3125.0 3160.6 219084.0 219948.0 219954.0 220106.0 221221.0 34489.0 34555.5 34596.7 34611.7 34629.5 35794.3 36164.8 36933.0 37012.6 39026.4 16181.7 16380.0 16486.9 16497.0 16504.5 12492.8 12622.6 12627.0 12642.3 12654.9 19812.2 20262.1 20393.3 20408.0 20470.8 7124.6 7507.1 7537.3 7566.5 7723.2 761.8 826.9 827.6 872.7 888.6 28233.8 29123.4 29673.9 29724.6 29895.9 1036.7 1042.2 1056.5 1102.0 1138.9 15429.9 15555.6 15654.5 15911.6 15963.6 371515.0 485851.0 486851.0 495587.0 784170.0 54214.2 54238.0 54599.7 54683.5 54877.0 1263.9 1267.0 1279.4 1304.1 1308.7 28800.0 30257.2 30470.8 30788.5 31313.7 45924.1 46402.3 46557.8 46643.3 46695.8 353784.0 356496.0 358923.0 359551.0 359971.0 27071.9 27493.9 27545.0 27634.9 27662.4 43655.8 44260.3 44592.0 44991.0 45513.5 37745.2 38057.0 38495.2 38528.8 38699.2 36059.5 37789.8 38314.2 38380.8 38791.0 37078.8 37169.8 37235.3 38086.6 38109.8 32562.3 33452.3 34264.0 34472.3 34577.5 25825.9 25845.7 25885.3 26419.8 26605.2 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#2] jquery.html Cycles:180 Average:24566.47 Median:22564.86 stddev:69806.79 (309.4%) stddev-sans-first:69979.00 05:48:06 INFO - PROCESS | 30627 | Values: 381.8 391.6 392.4 398.2 409.0 16170.4 16574.0 17405.7 17476.9 17526.6 9633.2 10093.2 10537.8 10538.2 10576.8 4659.4 4779.3 4781.8 5320.2 5458.2 5388.9 5397.2 5401.5 5419.1 5424.6 4951.4 4975.6 5239.7 5406.3 5422.7 4840.9 4932.1 4943.4 4954.2 4960.9 4727.0 4757.8 4798.5 4815.1 4894.7 18149.6 18169.3 19222.4 20416.8 20662.0 1920.5 1931.6 1935.9 1957.5 1982.7 9252.9 9373.4 9442.9 9815.2 9903.5 1768.8 1860.1 1864.3 1874.6 1933.3 66015.0 69379.7 69421.7 70328.0 70877.0 10225.6 10529.1 10547.6 10681.0 10785.4 14588.5 14726.3 14738.3 14739.1 14763.4 6625.7 7262.8 7621.6 7771.2 8015.6 7492.9 7514.8 7614.2 7712.4 7815.5 4370.3 4502.7 4523.6 4556.2 4578.4 1884.2 1902.4 1981.3 1987.8 2001.1 854.0 914.3 916.5 946.0 1062.6 10480.8 10506.2 10594.4 10659.6 10909.6 443.6 449.2 455.4 459.3 463.1 5828.3 6038.3 6089.3 6139.8 6195.2 416201.0 418997.0 422454.0 423107.0 434110.0 81626.2 81885.0 82122.0 84261.6 84427.0 467.8 470.4 471.6 472.5 473.9 10334.8 10374.3 10447.0 10505.0 10674.7 29866.0 34902.8 35326.0 35572.5 35952.0 39510.6 44680.6 45175.0 45201.8 46635.8 7798.7 7948.4 7967.0 8067.6 8150.8 11673.9 11696.1 11717.4 11753.8 11826.2 10640.5 10654.0 10784.3 10852.0 10857.1 5201.7 10584.6 10779.6 10906.1 10925.0 10566.5 11012.1 11058.7 11125.2 11207.5 7875.8 7898.1 7949.2 7976.5 8179.8 8049.6 9769.5 10687.3 10872.9 11166.2 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#3] mootools.html Cycles:180 Average:5134.25 Median:4988.80 stddev:2862.84 (57.4%) stddev-sans-first:2857.05 05:48:06 INFO - PROCESS | 30627 | Values: 1390.1 1459.9 1596.7 1692.6 1872.9 6495.8 7429.4 7487.6 7837.6 7871.1 7499.7 7770.7 7802.0 7804.0 7822.4 2222.1 2246.1 2246.3 2254.2 2256.2 2200.4 2203.7 2264.5 2265.4 2266.9 2220.8 2224.0 2226.5 2227.3 2248.1 2120.3 2147.1 2151.4 2156.4 2156.8 2167.5 2183.0 2189.7 2199.8 2212.5 7786.6 7793.7 7831.2 7848.5 7860.0 4667.8 4779.5 4789.8 4830.9 4835.8 2780.5 3036.6 3050.6 3063.3 3102.6 931.2 937.5 938.6 950.6 955.0 10502.5 10517.3 10556.6 10558.6 10562.9 4305.1 4317.3 4416.9 4423.6 4510.5 9046.9 9119.8 9129.5 9135.8 9155.9 4749.8 4793.5 4800.4 4819.0 4820.1 3672.9 4235.5 4257.3 4353.4 4372.0 3607.2 3667.4 3758.9 3760.4 3842.2 1198.3 1203.8 1220.1 1220.3 1230.0 737.4 760.1 792.4 798.8 804.6 4970.3 5007.3 5007.9 5083.1 5120.4 419.0 428.1 431.0 431.1 439.2 3402.9 3418.6 3438.6 3469.6 3493.6 9286.5 9389.8 9711.0 9719.9 9730.8 9466.7 9487.9 9508.9 9603.8 9655.2 7231.6 7277.7 7285.3 7303.2 7312.6 5028.5 5089.8 5135.7 5150.1 5154.7 8419.5 8714.4 8733.6 8745.6 8850.4 8869.2 8955.1 9043.6 9054.8 9067.0 5955.4 6747.7 6759.1 6847.6 6991.3 7675.7 7685.8 7730.7 7753.7 7765.6 6623.6 6813.8 6835.0 6868.8 6888.0 6755.4 6803.4 6835.7 6944.1 7005.3 6256.9 6291.3 6350.2 6356.7 6362.0 4562.6 4591.5 4628.9 4657.2 4666.6 4517.8 4555.4 4618.3 4658.2 4667.0 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#4] prototype.html Cycles:180 Average:4142.94 Median:4491.30 stddev:1197.34 (26.7%) stddev-sans-first:1165.60 05:48:06 INFO - PROCESS | 30627 | Values: 308.9 313.7 321.1 321.9 327.4 4819.3 4935.5 5024.2 5035.9 5083.2 4882.1 4904.0 4922.6 5015.8 5022.4 3917.0 3923.2 3933.8 3938.1 3939.0 3652.6 3947.4 3948.6 3962.3 3989.4 3820.4 3838.5 3838.5 3839.3 3840.6 3834.9 3848.2 3864.9 3871.5 3873.4 3403.3 3408.2 3411.2 3437.4 3439.4 4578.5 4751.2 4754.5 4817.5 4855.7 4314.5 4362.4 4387.7 4397.7 4403.6 5156.8 5157.4 5169.9 5182.7 5190.4 3582.4 3691.3 3726.6 3748.3 3759.0 5460.7 5484.8 5487.9 5488.5 5492.8 3818.3 3821.6 3823.5 3826.4 3851.8 3877.7 3891.8 3893.3 3900.1 3906.6 4336.7 4402.7 4413.7 4417.3 4418.3 5236.6 5242.4 5248.4 5271.6 5285.0 1236.1 1284.5 1314.2 1327.9 1332.5 844.1 844.5 849.3 868.7 875.8 3998.8 4000.7 4072.3 4076.5 4091.0 4632.0 4668.9 4668.9 4701.5 4729.3 4025.8 4038.4 4040.6 4062.8 4071.0 2358.6 2532.4 2536.8 2540.2 2558.0 4447.8 4476.9 4484.7 4497.9 4519.6 4748.0 4784.4 4786.5 4866.2 4899.7 4261.9 4298.8 4459.9 4501.6 4510.3 4650.6 4733.3 4743.0 4761.5 4792.0 4662.8 4678.9 4693.1 4714.0 4735.5 4308.6 4439.7 4457.2 4458.8 4465.8 3374.7 3434.3 3453.4 3462.4 3479.8 4637.8 4701.2 4707.3 4708.4 5155.5 5070.8 5194.9 5218.7 5224.5 5234.2 5163.6 5172.5 5186.5 5199.6 5227.6 5021.3 5080.3 5113.1 5120.9 5152.9 5232.8 5243.7 5253.0 5274.4 5287.2 5107.6 5120.2 5130.9 5145.7 5171.2 05:48:06 INFO - PROCESS | 30627 | 05:48:06 INFO - PROCESS | 30627 | [#5] yui.html Cycles:180 Average:12778.41 Median:3918.17 stddev:14417.64 (368.0%) stddev-sans-first:14429.60 05:48:06 INFO - PROCESS | 30627 | Values: 709.2 733.0 760.9 773.4 773.8 11390.7 11809.7 12072.8 12101.1 12154.2 11423.4 11480.9 11499.3 11513.0 11515.3 685.5 860.6 866.9 873.9 882.6 865.7 866.9 874.9 875.2 878.0 907.2 910.0 910.4 911.9 913.0 902.0 907.0 907.1 912.2 915.1 669.3 671.4 672.7 673.8 674.0 12883.2 12899.2 12901.6 12928.7 12955.0 12516.2 12550.6 12630.0 12641.4 12710.3 10352.2 10428.7 10431.2 10460.7 10619.9 3302.0 3397.8 3403.5 3427.0 3471.3 47355.3 47520.8 48299.0 48404.8 48580.3 10192.3 10280.2 10431.9 10452.7 10493.2 15726.4 16411.2 16453.3 16472.0 16532.2 6388.6 6539.4 6852.1 6862.9 7108.8 3584.6 3733.3 3797.5 3880.8 3955.6 2748.5 2804.7 2875.1 2878.3 2889.4 495.4 502.2 513.6 529.8 534.1 434.1 501.7 509.2 512.6 560.6 7633.8 7635.8 7662.7 7860.9 8271.2 606.1 608.5 628.1 631.0 644.5 3369.5 3402.3 3572.8 3784.9 3986.9 50267.2 51971.7 52121.0 54816.7 55817.4 34258.3 45102.8 45121.3 46051.8 46927.0 42287.4 42658.8 43047.4 43349.0 43822.0 7165.1 7216.7 7248.9 7249.5 7536.7 28539.7 29212.4 29262.7 29758.7 30158.1 36666.8 37318.0 37819.6 38037.0 38195.0 10535.4 10680.9 10738.9 10755.6 10868.7 12039.5 12321.2 12347.8 12385.0 12454.6 11539.6 11623.4 11639.4 11693.7 11846.9 10982.6 11350.9 11623.6 11646.9 11732.1 11373.8 11474.9 11862.9 12006.1 12008.0 9501.7 9596.6 9962.7 10051.8 10397.2 9041.5 9296.3 9424.2 9855.0 9943.3 05:48:06 INFO - PROCESS | 30627 | -------- Summary: end -------- 05:48:06 INFO - PROCESS | 30627 | 05:48:07 INFO - TEST-INFO | 30627: exit 0 05:48:07 INFO - TEST-OK | dromaeo_css | took 1115658ms 05:48:07 INFO - TEST-START | kraken 05:48:07 INFO - operating with platform_type : linux_ 05:48:07 INFO - Initialising browser for kraken test... 05:48:07 INFO - TEST-INFO | started process 30855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCX323R/profile http://localhost:37056/getInfo.html) 05:48:11 INFO - PROCESS | 30855 | 05:48:11 INFO - PROCESS | 30855 | (process:30921): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:48:12 INFO - PROCESS | 30855 | __metrics Screen width/height:1600/1200 05:48:12 INFO - PROCESS | 30855 | colorDepth:24 05:48:12 INFO - PROCESS | 30855 | Browser inner width/height: 1024/697 05:48:12 INFO - PROCESS | 30855 | __metrics 05:48:13 ERROR - PROCESS | 30855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:48:13 INFO - TEST-INFO | 30855: exit 0 05:48:13 INFO - Browser initialized. 05:48:13 INFO - Running cycle 1/1 for kraken test... 05:48:13 INFO - TEST-INFO | started process 30972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCX323R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:15 INFO - PROCESS | 30972 | 05:48:15 INFO - PROCESS | 30972 | (process:31032): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:48:25 INFO - PROCESS | 30972 | RSS: Main: 164315136 05:48:25 INFO - PROCESS | 30972 | 05:48:28 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37056/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:29 INFO - PROCESS | 30972 | RSS: Main: 168521728 05:48:29 INFO - PROCESS | 30972 | 05:48:32 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37056/tests/kraken/driver.html?testName=audio-dft) 05:48:33 INFO - PROCESS | 30972 | RSS: Main: 168144896 05:48:33 INFO - PROCESS | 30972 | 05:48:36 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37056/tests/kraken/driver.html?testName=audio-fft) 05:48:36 INFO - PROCESS | 30972 | RSS: Main: 163217408 05:48:36 INFO - PROCESS | 30972 | 05:48:38 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37056/tests/kraken/driver.html?testName=audio-oscillator) 05:48:39 INFO - PROCESS | 30972 | RSS: Main: 164044800 05:48:39 INFO - PROCESS | 30972 | 05:48:41 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:42 INFO - PROCESS | 30972 | RSS: Main: 163811328 05:48:42 INFO - PROCESS | 30972 | 05:48:45 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37056/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:46 INFO - PROCESS | 30972 | RSS: Main: 164192256 05:48:46 INFO - PROCESS | 30972 | 05:48:49 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37056/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:50 INFO - PROCESS | 30972 | RSS: Main: 162607104 05:48:50 INFO - PROCESS | 30972 | 05:48:53 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37056/tests/kraken/driver.html?testName=json-parse-financial) 05:48:54 INFO - PROCESS | 30972 | RSS: Main: 163831808 05:48:54 INFO - PROCESS | 30972 | 05:48:56 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:56 INFO - PROCESS | 30972 | RSS: Main: 164143104 05:48:56 INFO - PROCESS | 30972 | 05:48:58 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:59 INFO - PROCESS | 30972 | RSS: Main: 164892672 05:48:59 INFO - PROCESS | 30972 | 05:49:01 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:02 INFO - PROCESS | 30972 | RSS: Main: 164917248 05:49:02 INFO - PROCESS | 30972 | 05:49:05 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:05 INFO - PROCESS | 30972 | RSS: Main: 164417536 05:49:05 INFO - PROCESS | 30972 | 05:49:08 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:09 INFO - PROCESS | 30972 | RSS: Main: 164343808 05:49:09 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | Cycle 1(1): loaded http://localhost:37056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37056/tests/kraken/driver.html?testName=ai-astar) 05:49:11 INFO - PROCESS | 30972 | RSS: Main: 166862848 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | __start_tp_report 05:49:11 INFO - PROCESS | 30972 | _x_x_mozilla_page_load 05:49:11 INFO - PROCESS | 30972 | _x_x_mozilla_page_load_details 05:49:11 INFO - PROCESS | 30972 | |i|pagename|runs| 05:49:11 INFO - PROCESS | 30972 | |0;ai-astar;112;116;107;114;116;113;109;114;112;114 05:49:11 INFO - PROCESS | 30972 | |1;audio-beat-detection;168;130;158;214;132;158;159;136;187;132 05:49:11 INFO - PROCESS | 30972 | |2;audio-dft;164;165;169;171;165;163;165;170;164;163 05:49:11 INFO - PROCESS | 30972 | |3;audio-fft;77;75;75;173;77;76;83;77;168;77 05:49:11 INFO - PROCESS | 30972 | |4;audio-oscillator;92;94;175;95;92;93;140;96;93;140 05:49:11 INFO - PROCESS | 30972 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;117;118;118 05:49:11 INFO - PROCESS | 30972 | |6;imaging-darkroom;149;147;147;148;147;148;148;148;146;147 05:49:11 INFO - PROCESS | 30972 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 05:49:11 INFO - PROCESS | 30972 | |8;json-parse-financial;69;68;70;67;68;68;71;68;80;69 05:49:11 INFO - PROCESS | 30972 | |9;json-stringify-tinderbox;64;64;64;64;64;65;65;65;65;64 05:49:11 INFO - PROCESS | 30972 | |10;stanford-crypto-aes;88;82;85;82;84;91;90;85;142;87 05:49:11 INFO - PROCESS | 30972 | |11;stanford-crypto-ccm;133;138;135;143;137;138;133;138;152;144 05:49:11 INFO - PROCESS | 30972 | |12;stanford-crypto-pbkdf2;180;179;183;178;180;174;176;180;176;180 05:49:11 INFO - PROCESS | 30972 | |13;stanford-crypto-sha256-iterative;73;71;71;67;68;68;76;69;69;69 05:49:11 INFO - PROCESS | 30972 | __end_tp_report 05:49:11 INFO - PROCESS | 30972 | __start_cc_report 05:49:11 INFO - PROCESS | 30972 | _x_x_mozilla_cycle_collect,928 05:49:11 INFO - PROCESS | 30972 | __end_cc_report 05:49:11 INFO - PROCESS | 30972 | __startTimestamp1462884551498__endTimestamp 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | ------- Summary: start ------- 05:49:11 INFO - PROCESS | 30972 | Number of tests: 14 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.87 (2.5%) stddev-sans-first:3.03 05:49:11 INFO - PROCESS | 30972 | Values: 112.0 116.0 107.0 114.0 116.0 113.0 109.0 114.0 112.0 114.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:158.50 stddev:27.27 (17.2%) stddev-sans-first:28.66 05:49:11 INFO - PROCESS | 30972 | Values: 168.0 130.0 158.0 214.0 132.0 158.0 159.0 136.0 187.0 132.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:2.96 (1.8%) stddev-sans-first:3.06 05:49:11 INFO - PROCESS | 30972 | Values: 164.0 165.0 169.0 171.0 165.0 163.0 165.0 170.0 164.0 163.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:39.45 (51.2%) stddev-sans-first:41.25 05:49:11 INFO - PROCESS | 30972 | Values: 77.0 75.0 75.0 173.0 77.0 76.0 83.0 77.0 168.0 77.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:93.00 stddev:29.66 (31.9%) stddev-sans-first:30.65 05:49:11 INFO - PROCESS | 30972 | Values: 92.0 94.0 175.0 95.0 92.0 93.0 140.0 96.0 93.0 140.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:49:11 INFO - PROCESS | 30972 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 05:49:11 INFO - PROCESS | 30972 | Values: 149.0 147.0 147.0 148.0 147.0 148.0 148.0 148.0 146.0 147.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:49:11 INFO - PROCESS | 30972 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:69.00 stddev:3.77 (5.5%) stddev-sans-first:3.98 05:49:11 INFO - PROCESS | 30972 | Values: 69.0 68.0 70.0 67.0 68.0 68.0 71.0 68.0 80.0 69.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:49:11 INFO - PROCESS | 30972 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 64.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:86.00 stddev:17.97 (20.9%) stddev-sans-first:19.01 05:49:11 INFO - PROCESS | 30972 | Values: 88.0 82.0 85.0 82.0 84.0 91.0 90.0 85.0 142.0 87.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.00 stddev:5.82 (4.2%) stddev-sans-first:5.74 05:49:11 INFO - PROCESS | 30972 | Values: 133.0 138.0 135.0 143.0 137.0 138.0 133.0 138.0 152.0 144.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:180.00 stddev:2.63 (1.5%) stddev-sans-first:2.74 05:49:11 INFO - PROCESS | 30972 | Values: 180.0 179.0 183.0 178.0 180.0 174.0 176.0 180.0 176.0 180.0 05:49:11 INFO - PROCESS | 30972 | 05:49:11 INFO - PROCESS | 30972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.73 (3.9%) stddev-sans-first:2.68 05:49:11 INFO - PROCESS | 30972 | Values: 73.0 71.0 71.0 67.0 68.0 68.0 76.0 69.0 69.0 69.0 05:49:11 INFO - PROCESS | 30972 | -------- Summary: end -------- 05:49:11 INFO - PROCESS | 30972 | 05:49:12 INFO - TEST-INFO | 30972: exit 0 05:49:12 INFO - TEST-OK | kraken | took 65134ms 05:49:12 INFO - SUITE-END | took 1180s 05:49:12 INFO - Completed test suite (00:19:40) 05:49:12 INFO - javascript benchmark 05:49:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.8011899107564, 2698.082651898354, 2710.2004908551976, 2717.171262764857, 2734.412101398199, 4748.596369308609, 4838.0, 4872.75636218189, 4884.658073934826, 4956.900861982758, 4714.882127946803, 4813.56677898989, 4841.491643377448, 4856.465788763242, 4887.706737595747, 4405.889852753683, 4434.623057040156, 4539.137563862872, 4546.47715512717, 4562.315652652095, 631.9196641469614, 4162.854300099497, 4377.365282034103, 4394.362817391477, 4477.977610111945, 4366.279563871942, 4403.801828917706, 4405.933910991338, 4422.911541769179, 4423.491298500681, 4397.252467080604, 4415.337699345124, 4416.1609294233995, 4417.403650507173, 4460.375547423363, 4353.259945809188, 4405.876501492131, 4407.0, 4410.823567057314, 4425.5353187915125, 4716.221823399135, 4740.312654665088, 4752.52474752522, 4759.904801903977, 4769.070031343855, 4977.875553111201, 5046.798128074873, 5155.32980712505, 5173.870653233662, 5187.584993200535, 5066.847994560169, 5101.744912754348, 5148.459411761749, 5148.536631703165, 5178.40448348441, 4772.069446457942, 4854.296127061556, 4865.5864251539015, 4879.682820616648, 4917.975410122998, 5265.947340526545, 5281.656692314988, 5345.1714984177515, 5355.143177091724, 5355.518003379714, 5096.108181068298, 5132.79468821243, 5139.074966506065, 5141.511556402136, 5142.5628821549835, 5210.400803907523, 5221.138512145453, 5221.425643179247, 5222.634415590872, 5247.317848679647, 4980.352554167935, 5140.1004824155625, 5177.378714554277, 5220.216967454912, 5243.580513558906, 5149.948500515022, 5171.095058364771, 5177.4822517747925, 5203.973980130075, 5248.186531087687, 4334.176506463762, 4463.928657122267, 4497.257952437811, 4512.0, 4559.566841150086, 3775.565809931838, 3798.810059497014, 3849.9037524062123, 3853.0560012797046, 3888.3389823730035, 4462.642988560908, 4502.234620114523, 4515.367848501212, 4547.295169248771, 4584.862454126382, 5258.789648414021, 5265.710385928811, 5279.41926388097, 5280.234366016906, 5285.709285989307, 4429.889252768642, 4443.600075993176, 4479.484859241164, 4494.9325760113625, 4502.4371953505815, 4682.508336624674, 4730.59789917854, 4731.668783185144, 4734.19518681825, 4777.283407488904, 4728.905421891612, 4890.168671325883, 4892.730899800403, 4916.0, 4946.802127914915, 5216.452272511332, 5274.182501712241, 5294.470552944675, 5299.788008479618, 5347.679139251657, 4793.784279707352, 4823.782929768098, 4828.565429111397, 4833.879153021203, 4881.194602890625, 4958.380202474691, 5104.821331253388, 5113.974430127825, 5116.360454943132, 5133.820316288912, 5113.463086375877, 5173.767180476812, 5205.505476979681, 5210.921836172536, 5212.0, 5047.116754568009, 5077.8730531737, 5089.720065396439, 5092.745362731923, 5141.074606570854, 4848.61211103118, 5060.595152387874, 5084.720340381315, 5091.974540127276, 5097.847064588068, 4996.125678006407, 5020.949790502048, 5067.493250674903, 5087.3386459759995, 5128.333316668958, 5182.689038657692, 5188.351456067991, 5193.558547523352, 5198.8177731415335, 5247.1079916415065, 4809.903801923872, 4951.925721114114, 4960.751962401793, 5081.593472522263, 5092.210707340369], "value": 4735.515562362248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.513363640905, 605.2857627998962, 609.1259043272904, 621.2327775197632, 639.7249182851372, 38758.22483550327, 43133.35299970503, 43153.0, 43222.0, 43410.565894341045, 43958.340624890654, 44598.33102503465, 44688.0, 44694.55305446945, 44827.77586112073, 7924.44528882977, 8056.798580035516, 8060.637271322805, 8091.838163236732, 8098.554579498125, 7946.443748937577, 7970.481918675297, 8006.759797206064, 8016.438849280553, 8042.356611471068, 7829.608519574027, 7857.607119644023, 7865.4887432317, 7873.173316801739, 7873.291403773688, 7998.200179981985, 8002.639881205359, 8004.559749213791, 8004.799880002988, 8022.478538894982, 7938.285554300083, 7984.600769961537, 7988.121306656321, 7988.920110798876, 8007.839843203162, 31448.0, 40384.79807600943, 40848.387274190914, 40904.79547602273, 41155.794221029006, 2930.9009121579406, 2957.837318947457, 3004.8347340896244, 3322.4185767490594, 3403.2172600301824, 28658.570121448196, 28765.856170719013, 28886.711132888824, 29218.033113903894, 29238.853805731047, 3081.1988882890387, 3081.5223640335785, 3104.8292343921075, 3124.9687503124906, 3160.573322601442, 219084.0, 219948.0, 219953.9999999984, 220106.0, 221221.0, 34489.0, 34555.481667775006, 34596.65403345985, 34611.653883461346, 34629.480557791656, 35794.28411431757, 36164.819175903955, 36933.0, 37012.62987370092, 39026.41460378097, 16181.676366472604, 16380.0, 16486.917565412095, 16497.0, 16504.504864854072, 12492.750144997231, 12622.621321360373, 12627.0, 12642.304673242876, 12654.873451265554, 19812.20751169937, 20262.088206030763, 20393.286234981704, 20408.0, 20470.79529204689, 7124.5725256484775, 7507.099148102263, 7537.283958023979, 7566.546007239584, 7723.189065148191, 761.7981234972737, 826.8553003224412, 827.606886728811, 872.7076429396224, 888.6401007591936, 28233.77140581458, 29123.417531649247, 29673.85163074214, 29724.55413168804, 29895.850520747255, 1036.657902892059, 1042.213129087534, 1056.4612047855649, 1101.9971825638631, 1138.9031932285848, 15429.922850385676, 15555.611109722347, 15654.530364089096, 15911.602209944613, 15963.600909977344, 371515.0, 485851.0, 486851.0, 495587.0, 784170.0, 54214.186787198225, 54238.0, 54599.727001365536, 54683.45316546863, 54877.0, 1263.8988880889506, 1266.9619911402672, 1279.3731071774948, 1304.0675916719401, 1308.6662900960384, 28800.0, 30257.24356891095, 30470.84764576163, 30788.53440777462, 31313.686863131075, 45924.08151837011, 46402.30396544122, 46557.76721116373, 46643.30035049409, 46695.76652116718, 353784.0, 356496.0, 358923.0, 359551.0, 359971.0, 27071.86464067667, 27493.86253068722, 27545.035923742573, 27634.861825691547, 27662.44675106527, 43655.78172109119, 44260.336094959246, 44592.0, 44991.0, 45513.544864552256, 37745.24509509849, 38057.0, 38495.230095398496, 38528.80735596304, 38699.22601547897, 36059.45910811392, 37789.81105094457, 38314.233715326096, 38380.80809595934, 38791.0, 37078.8146059268, 37169.81415093016, 37235.255294894494, 38086.61913380831, 38109.80945095257, 32562.348753024333, 33452.330953381286, 34264.0, 34472.310553789284, 34577.48133777945, 25825.870870645525, 25845.741542584332, 25885.289272700196, 26419.838982209138, 26605.201843944713], "value": 18027.673894561347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7919234017459, 391.5536288630961, 392.4107562061686, 398.18968399307397, 408.9714368363566, 16170.353185872566, 16574.0, 17405.738913916302, 17476.912615436922, 17526.561835954108, 9633.229341652668, 10093.243006774503, 10537.789244215111, 10538.209634277422, 10576.78846423071, 4659.4175728034, 4779.330893674888, 4781.760911954406, 5320.228566857803, 5458.153986132156, 5388.91916621251, 5397.2443857859935, 5401.513863752261, 5419.132938729804, 5424.620276580641, 4951.430585482662, 4975.577075948549, 5239.73801309933, 5406.324209473816, 5422.674639521641, 4840.854774356775, 4932.112219800452, 4943.431505376891, 4954.157793175169, 4960.851174464772, 4727.007328461027, 4757.78589963449, 4798.496157903405, 4815.0610630926985, 4894.657373983822, 18149.637007259913, 18169.273229070823, 19222.423327300203, 20416.795832041786, 20662.0, 1920.4910698664864, 1931.6329897319604, 1935.8741681790639, 1957.530192753743, 1982.7025946108056, 9252.8612070819, 9373.437593744397, 9442.90557094434, 9815.21478281743, 9903.45530995795, 1768.8408043276168, 1860.0513737993585, 1864.2915692036938, 1874.55010797409, 1933.3426634944187, 66015.0, 69379.65310173416, 69421.65289173572, 70327.99999999949, 70877.0, 10225.642102526375, 10529.105026072717, 10547.578096876192, 10680.999999999845, 10785.40680262593, 14588.489402870848, 14726.33731482086, 14738.263086845614, 14739.115653060851, 14763.409463621334, 6625.701843417058, 7262.818429539198, 7621.618919054025, 7771.222877712296, 8015.599220039091, 7492.850142997109, 7514.812129696801, 7614.162442131361, 7712.383009359238, 7815.491993020435, 4370.322599997005, 4502.707324023928, 4523.570260825217, 4556.157110934488, 4578.404807375086, 1884.1992153334777, 1902.3912348048768, 1981.3362523554483, 1987.7813440521531, 2001.119507416732, 853.99558586682, 914.2503147419053, 916.4867674102524, 945.9810803783886, 1062.6227689170387, 10480.842787358195, 10506.212034097472, 10594.417307048187, 10659.626913058006, 10909.563617455213, 443.59854331829104, 449.17576247586044, 455.3920516110963, 459.27893207663647, 463.1038939651785, 5828.271466066742, 6038.30559485656, 6089.2997305310455, 6139.846503837351, 6195.2255968004, 416201.0, 418997.0, 422454.0, 423107.0, 434110.0, 81626.18373816185, 81885.0, 82122.0, 84261.57869210615, 84427.0, 467.8175511550498, 470.39554172887676, 471.5567366675383, 472.4802717011329, 473.862579851846, 10334.844977325196, 10374.27380083387, 10447.0, 10505.0, 10674.73313167177, 29865.95469158569, 34902.82548587241, 35326.0, 35572.466413004346, 35952.0, 39510.604893950695, 44680.55319446764, 45175.0, 45201.773991129834, 46635.76682116568, 7798.727044553413, 7948.364130869632, 7966.960165199137, 8067.596620168851, 8150.796230094295, 11673.941630291794, 11696.122790790554, 11717.355545445082, 11753.823692644788, 11826.172167948162, 10640.52117654692, 10654.0, 10784.299020563638, 10852.0, 10857.077148442471, 5201.7399130044105, 10584.629537966443, 10779.568817247537, 10906.127509799038, 10925.0, 10566.524506397383, 11012.119030477703, 11058.723531911766, 11125.165612578927, 11207.49566269536, 7875.763727088197, 7898.091719452107, 7949.244821741925, 7976.521408715495, 8179.836403271782, 8049.637766300648, 9769.511524423893, 10687.25189236746, 10872.945635271773, 11166.218364714392], "value": 7602.462280832676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.0755997261817, 1459.9270036498176, 1596.6726821001696, 1692.5599344170512, 1872.8501719862404, 6495.772647957322, 7429.442791790624, 7487.550746955179, 7837.568933708644, 7871.094824095231, 7499.725046742054, 7770.68917243311, 7802.0, 7803.960980195106, 7822.374210063182, 2222.1111555377856, 2246.0903334149616, 2246.33733048751, 2254.222293308806, 2256.187772401934, 2200.3728937252886, 2203.6584329428965, 2264.547090581882, 2265.399669087693, 2266.9206577769783, 2220.844540882139, 2223.9777602224012, 2226.532428190082, 2227.287268074217, 2248.067052173346, 2120.300300900699, 2147.076756994492, 2151.3868547463976, 2156.35309407178, 2156.784321567831, 2167.4689701023194, 2182.9890850545803, 2189.715337006195, 2199.846010779246, 2212.4800671842104, 7786.649600767979, 7793.688252469894, 7831.216878312181, 7848.450608457353, 7859.96070019652, 4667.766611669437, 4779.474257831671, 4789.760511974422, 4830.9275360869615, 4835.782389792468, 2780.5134101532353, 3036.6052413186367, 3050.6339239291206, 3063.2954420483193, 3102.5811515445353, 931.2177770672599, 937.5452905340904, 938.6057855700553, 950.5579905344048, 955.016333176829, 10502.474876256156, 10517.316374435637, 10556.577736890515, 10558.577656893714, 10562.894371056267, 4305.138972205571, 4317.330813723878, 4416.889577760582, 4423.646108311392, 4510.503844577094, 9046.909530904606, 9119.817603648022, 9129.45223286605, 9135.817283654422, 9155.862662060075, 4749.810007599726, 4793.520647935178, 4800.3759511263315, 4818.951810481921, 4820.060088282821, 3672.944905826415, 4235.53409124996, 4257.27626303523, 4353.390525326457, 4371.956280437218, 3607.2244467439627, 3667.431548110047, 3758.924821503609, 3760.4359346098304, 3842.2315536892734, 1198.3469009389903, 1203.7773011992808, 1220.097128125181, 1220.2922305063219, 1229.9815502767465, 737.4211244173298, 760.125855266448, 792.4175730837829, 798.7923139983646, 804.63389157933, 4970.254461830755, 5007.349044624249, 5007.874803129951, 5083.135866902636, 5120.385553733501, 418.9560096189917, 428.05186511876343, 430.984915527955, 431.0903992575663, 439.2159994409963, 3402.897913062612, 3418.5555877736233, 3438.570178727659, 3469.6356882527475, 3493.633168517269, 9286.535673216447, 9389.765255868659, 9710.951445242728, 9719.854202186973, 9730.805383892424, 9466.668666596635, 9487.857682134774, 9508.857367139499, 9603.807923841485, 9655.22758179344, 7231.602261875647, 7277.726397880349, 7285.344319011315, 7303.160136584361, 7312.634368281565, 5028.547430731105, 5089.821856235014, 5135.6918584885025, 5150.072986862401, 5154.664946778447, 8419.452735572168, 8714.389992700704, 8733.606987685442, 8745.56272186401, 8850.38047336706, 8869.201771840566, 8955.104489550993, 9043.593038313424, 9054.773630659287, 9066.95466522663, 5955.404459554184, 6747.730090796314, 6759.087523184307, 6847.589144651337, 6991.335823096798, 7675.692972281046, 7685.807854803675, 7730.729424470116, 7753.689852405841, 7765.5728934906865, 6623.635700036544, 6813.829654258683, 6834.965825171042, 6868.828279293058, 6888.0356750056035, 6755.3582409671, 6803.387695107464, 6835.658217089225, 6944.062551555678, 7005.264447233171, 6256.937430625636, 6291.339409361951, 6350.237971443272, 6356.745730170742, 6361.968190159019, 4562.58936695699, 4591.494935557019, 4628.907421851612, 4657.231556793226, 4666.603338716247, 4517.774111294357, 4555.362249285036, 4618.284165954283, 4658.208104622155, 4667.0], "value": 4082.8966097839384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8918878392563, 313.72549019607845, 321.1281371077525, 321.9002109346104, 327.4286370283855, 4819.277108433736, 4935.457099719028, 5024.221245706916, 5035.924461133086, 5083.18669012958, 4882.145624515704, 4903.9754801225945, 4922.581580565657, 5015.799368025284, 5022.447530771612, 3916.9608303916953, 3923.1761330120707, 3933.7639741615453, 3938.1139243670086, 3939.0, 3652.5799533053773, 3947.3881548359905, 3948.644621984021, 3962.2669806085823, 3989.421533877586, 3820.4269359596005, 3838.500994870677, 3838.539375274957, 3839.289731399686, 3840.596737342567, 3834.8657796976972, 3848.1726428817797, 3864.942025869614, 3871.5160604924386, 3873.4189871519216, 3403.3193361327585, 3408.164999575095, 3411.232472693649, 3437.3984552703178, 3439.4496880499, 4578.473475550321, 4751.1922973094315, 4754.453237877654, 4817.530653150788, 4855.660103792736, 4314.482262128533, 4362.36745671879, 4387.714798538085, 4397.6587140922, 4403.603675669173, 5156.767945442464, 5157.381114266312, 5169.896602067975, 5182.689038657692, 5190.4047976012, 3582.4089025311055, 3691.2617476504806, 3726.608706085849, 3748.287825313209, 3758.962410375889, 5460.672359658433, 5484.8354549363585, 5487.862803429906, 5488.53347465466, 5492.81904390558, 3818.293615681108, 3821.5987321331418, 3823.5411750590106, 3826.4069069294305, 3851.807409629507, 3877.728559000899, 3891.8248678809523, 3893.3381325174787, 3900.083480382108, 3906.570277269498, 4336.696431249846, 4402.719004689142, 4413.668974826901, 4417.293233082692, 4418.315161150027, 5236.6334356595435, 5242.370915490165, 5248.396434410091, 5271.551918087006, 5285.0, 1236.1285293867802, 1284.4797856867983, 1314.1589382795019, 1327.9468821247042, 1332.5136325241217, 844.1389782421895, 844.4553263145237, 849.3205435651454, 868.700298397052, 875.8467268228035, 3998.8203479973477, 4000.6799456043445, 4072.328065869158, 4076.510818701775, 4090.9590904091174, 4631.9536804631525, 4668.879468927433, 4668.906621867543, 4701.48283688794, 4729.266963620576, 4025.75845449274, 4038.3538633819035, 4040.575739547364, 4062.837486500566, 4071.0, 2358.6462030695534, 2532.3669082729316, 2536.771690547823, 2540.2125341143933, 2557.974420255811, 4447.822087116479, 4476.865694029184, 4484.686071974996, 4497.910041799146, 4519.6441067680225, 4747.95252047482, 4784.4497882743235, 4786.473487916326, 4866.197077482247, 4899.657024008286, 4261.850835220753, 4298.76356800379, 4459.888502787457, 4501.617362524156, 4510.2783554631105, 4650.604818554352, 4733.290006498915, 4742.976285118552, 4761.452432970114, 4792.046561586774, 4662.836800711959, 4678.906421871611, 4693.108309421199, 4713.976430117965, 4735.455422626442, 4308.590683885026, 4439.711418757771, 4457.242268814244, 4458.777061146865, 4465.821367145278, 3374.7300215983155, 3434.3131373724855, 3453.378391889484, 3462.428699264593, 3479.8434070466383, 4637.768111594474, 4701.224297990793, 4707.340972263817, 4708.387909571734, 5155.484451554815, 5070.771815268248, 5194.922076168936, 5218.712970786643, 5224.477552244745, 5234.18870075139, 5163.586913046872, 5172.456892026283, 5186.521841275218, 5199.55803756685, 5227.634065615523, 5021.297018417497, 5080.26336181259, 5113.130767769414, 5120.923186152137, 5152.922706159486, 5232.790688372575, 5243.659162154448, 5253.0, 5274.419813820554, 5287.206918962032, 5107.565856902205, 5120.155174396332, 5130.8973820524125, 5145.665531740425, 5171.172612382001], "value": 3770.207313599921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2163159708525, 732.9706811727531, 760.8592410404076, 773.4083426178975, 773.8336257704594, 11390.658280251586, 11809.70475738107, 12072.818907716392, 12101.092418068647, 12154.20997635153, 11423.371714555697, 11480.942595287033, 11499.3100413975, 11513.021393181589, 11515.309081455098, 685.4858855858106, 860.5912191708951, 866.9219770220678, 873.9257163141109, 882.6160620130264, 865.7056600755742, 866.8916385451819, 874.8731433942074, 875.1598465473154, 877.9824403511958, 907.2152588011355, 909.9863502047475, 910.4082346474811, 911.8814554107956, 913.0458670689146, 902.0213068820306, 907.0, 907.0611916666285, 912.16536868765, 915.1397686174975, 669.2738378858944, 671.3957438305564, 672.6972862212024, 673.8012286375531, 674.0428591400174, 12883.227006379648, 12899.161554499022, 12901.612951611467, 12928.676783080498, 12955.0, 12516.249025058525, 12550.560730374484, 12630.0, 12641.367931603383, 12710.271052040938, 10352.171826253882, 10428.687139385755, 10431.21765867563, 10460.68617941463, 10619.94690026545, 3301.950470742941, 3397.8301084945656, 3403.4724617684296, 3426.9828650856584, 3471.288385880888, 47355.289670654965, 47520.7623961878, 48299.03401931977, 48404.75797621025, 48580.27129593024, 10192.286539942133, 10280.22898282617, 10431.94784026075, 10452.68641940743, 10493.160547156209, 15726.449574264845, 16411.1794410279, 16453.341866325212, 16472.0, 16532.173391330387, 6388.552801303864, 6539.378759017885, 6852.074969879002, 6862.9313706863295, 7108.786736397813, 3584.605693373727, 3733.328000959799, 3797.525309336333, 3880.767153970771, 3955.564887862333, 2748.5464898291957, 2804.7195280471788, 2875.1230874583034, 2878.309205790637, 2889.3787835615444, 495.38077403245944, 502.1964856230003, 513.609656660933, 529.7827890564927, 534.0653855752433, 434.0845572932197, 501.7390956702494, 509.15480302697347, 512.5976108754684, 560.6243816642859, 7633.809154771064, 7635.847283054308, 7662.693492260247, 7860.921390786133, 8271.2142346477, 606.1483615520201, 608.5162295974711, 628.1174949196295, 630.9558330916883, 644.5230529408204, 3369.5451114099283, 3402.2515046689687, 3572.8392222350058, 3784.8675296364495, 3986.86045988389, 50267.24599131016, 51971.74014129981, 52121.0, 54816.72591637016, 55817.441825582035, 34258.314833703684, 45102.774486128015, 45121.32318015232, 46051.76974115108, 46927.0, 42287.365689514685, 42658.786706066894, 43047.35428968568, 43348.99999999937, 43822.0, 7165.140183178052, 7216.675249613675, 7248.927510725036, 7249.528780629243, 7536.660850261642, 28539.714602853706, 29212.415751685272, 29262.707372925997, 29758.702412976458, 30158.095257142322, 36666.81666591757, 37318.0, 37819.62180378161, 38037.0, 38195.0, 10535.42055186972, 10680.946595267285, 10738.892611074101, 10755.623553175601, 10868.67393978182, 12039.458224379749, 12321.199122057396, 12347.814782778445, 12385.009199263857, 12454.626361209179, 11539.624699437363, 11623.418829058683, 11639.41802909868, 11693.707657308636, 11846.940765296118, 10982.615608453985, 11350.94324528372, 11623.59317423886, 11646.88353116458, 11732.12009099304, 11373.772524549297, 11474.885251147381, 11862.881371186522, 12006.09954253417, 12008.0, 9501.667441639509, 9596.616135354509, 9962.651307204213, 10051.798964020532, 10397.16822654201, 9041.547922603711, 9296.349255552046, 9424.198943089914, 9854.950725246616, 9943.25425593069], "value": 5998.601547678915, "unit": "score"}], "name": "dromaeo_css", "value": 6255.795353707556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 107.0, 114.0, 116.0, 113.0, 109.0, 114.0, 112.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 130.0, 158.0, 214.0, 132.0, 158.0, 159.0, 136.0, 187.0, 132.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 169.0, 171.0, 165.0, 163.0, 165.0, 170.0, 164.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 173.0, 77.0, 76.0, 83.0, 77.0, 168.0, 77.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 175.0, 95.0, 92.0, 93.0, 140.0, 96.0, 93.0, 140.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 67.0, 68.0, 68.0, 71.0, 68.0, 80.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 85.0, 82.0, 84.0, 91.0, 90.0, 85.0, 142.0, 87.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 135.0, 143.0, 137.0, 138.0, 133.0, 138.0, 152.0, 144.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 183.0, 178.0, 180.0, 174.0, 176.0, 180.0, 176.0, 180.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 67.0, 68.0, 68.0, 76.0, 69.0, 69.0, 69.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1616.8999999999996, "alertThreshold": 2.0}]} 05:49:12 INFO - Return code: 0 05:49:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:49:12 ERROR - # TBPL SUCCESS # 05:49:12 INFO - Running post-action listener: _resource_record_post_action 05:49:12 INFO - ##### 05:49:12 INFO - ##### Finished run-tests step (success) 05:49:12 INFO - ##### 05:49:12 INFO - Running post-run listener: _resource_record_post_run 05:49:13 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 528986112; Read time: 12; Write time: 378380 05:49:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234901504; Read time: 0; Write time: 224576 05:49:13 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294084608; Read time: 12; Write time: 153804 05:49:13 INFO - Running post-run listener: _upload_blobber_files 05:49:13 INFO - Blob upload gear active. 05:49:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:13 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 05:49:13 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'] 05:49:13 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 05:49:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:49:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:14 INFO - (blobuploader) - INFO - Done attempting. 05:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:15 INFO - (blobuploader) - INFO - Done attempting. 05:49:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:15 INFO - Return code: 0 05:49:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a7a1e7f0022271678094bee1e7e252edc0aad2b044a7c3bd06bc5a5f2c6850ef58d198db3d808953e331528632a1cbb55db64c8eb3dafb0b451b098133597e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98c1fa69369f7a4dad7e6b2c19803d2cfba611c212eb4fb649d7d92cb4ba2da88da46db302224adb75b3adbd3bae9ceccb56a79489560c15984986126a2e4a2f"} 05:49:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:15 INFO - Contents: 05:49:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a7a1e7f0022271678094bee1e7e252edc0aad2b044a7c3bd06bc5a5f2c6850ef58d198db3d808953e331528632a1cbb55db64c8eb3dafb0b451b098133597e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98c1fa69369f7a4dad7e6b2c19803d2cfba611c212eb4fb649d7d92cb4ba2da88da46db302224adb75b3adbd3bae9ceccb56a79489560c15984986126a2e4a2f"} 05:49:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:15 INFO - Copying logs to upload dir... 05:49:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.859230 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-10 05:49:14.816421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:49:14.819938) ========= 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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 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/5a7a1e7f0022271678094bee1e7e252edc0aad2b044a7c3bd06bc5a5f2c6850ef58d198db3d808953e331528632a1cbb55db64c8eb3dafb0b451b098133597e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98c1fa69369f7a4dad7e6b2c19803d2cfba611c212eb4fb649d7d92cb4ba2da88da46db302224adb75b3adbd3bae9ceccb56a79489560c15984986126a2e4a2f"} build_url:https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/BW-ipY19QM2UD_yxY_b61A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5a7a1e7f0022271678094bee1e7e252edc0aad2b044a7c3bd06bc5a5f2c6850ef58d198db3d808953e331528632a1cbb55db64c8eb3dafb0b451b098133597e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98c1fa69369f7a4dad7e6b2c19803d2cfba611c212eb4fb649d7d92cb4ba2da88da46db302224adb75b3adbd3bae9ceccb56a79489560c15984986126a2e4a2f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:49:14.844516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:49:14.844844) ========= 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=574dc5aafe09851ec43d388c000001b6-1462883319.446751-827742947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:49:14.928351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:49:14.928692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:49:14.928985) ========= ========= Total master_lag: 0.15 =========