builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1466582319.42 results: success (0) buildid: 20160622000716 builduid: 362ce1e45b0d45f6bb162cfd180003ea revision: 0d361d105c86ff3443c06a7387b994d75035178e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.415462) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.415992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.416332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.484546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.484910) ========= 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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 00:58:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-22 00:58:39 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166757 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.704281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.704656) ========= 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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041015 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.757222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.757597) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d361d105c86ff3443c06a7387b994d75035178e --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 0d361d105c86ff3443c06a7387b994d75035178e --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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 00:58:40,020 truncating revision to first 12 chars 2016-06-22 00:58:40,020 Setting DEBUG logging. 2016-06-22 00:58:40,020 attempt 1/10 2016-06-22 00:58:40,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d361d105c86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 00:58:40,325 unpacking tar archive at: fx-team-0d361d105c86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682694 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:40.455797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:40.456309) ========= script_repo_revision: 0d361d105c86ff3443c06a7387b994d75035178e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:40.457065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:40.457562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:40.467283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-22 00:58:40.467632) ========= /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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:58:40 INFO - MultiFileLogger online at 20160622 00:58:40 in /builds/slave/test 00:58:40 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 00:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:58:40 INFO - {'append_to_log': False, 00:58:40 INFO - 'base_work_dir': '/builds/slave/test', 00:58:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:58:40 INFO - 'branch': 'Fx-Team-Non-PGO', 00:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:58:40 INFO - 'config_files': ('talos/linux_config.py',), 00:58:40 INFO - 'default_actions': ('clobber', 00:58:40 INFO - 'read-buildbot-config', 00:58:40 INFO - 'download-and-extract', 00:58:40 INFO - 'populate-webroot', 00:58:40 INFO - 'create-virtualenv', 00:58:40 INFO - 'install', 00:58:40 INFO - 'run-tests'), 00:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:58:40 INFO - 'download_minidump_stackwalk': True, 00:58:40 INFO - 'download_symbols': 'ondemand', 00:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:58:40 INFO - 'installer_path': 'installer.exe', 00:58:40 INFO - 'log_level': 'info', 00:58:40 INFO - 'log_name': 'talos', 00:58:40 INFO - 'log_to_console': True, 00:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:58:40 INFO - 'opt_config_files': (), 00:58:40 INFO - 'pip_index': False, 00:58:40 INFO - 'sps_profile': False, 00:58:40 INFO - 'sps_profile_interval': 0, 00:58:40 INFO - 'suite': 'dromaeojs-e10s', 00:58:40 INFO - 'system_bits': '32', 00:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:58:40 INFO - 'title': 'talos-linux64-ix-052', 00:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:58:40 INFO - 'use_talos_json': True, 00:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:58:40 INFO - 'work_dir': 'build'} 00:58:40 INFO - ##### 00:58:40 INFO - ##### Running clobber step. 00:58:40 INFO - ##### 00:58:40 INFO - Running pre-action listener: _resource_record_pre_action 00:58:40 INFO - Running main action method: clobber 00:58:40 INFO - rmtree: /builds/slave/test/build 00:58:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:58:43 INFO - Running post-action listener: _resource_record_post_action 00:58:43 INFO - ##### 00:58:43 INFO - ##### Finished clobber step (success) 00:58:43 INFO - ##### 00:58:43 INFO - ##### 00:58:43 INFO - ##### Running read-buildbot-config step. 00:58:43 INFO - ##### 00:58:43 INFO - Running pre-action listener: _resource_record_pre_action 00:58:43 INFO - Running main action method: read_buildbot_config 00:58:43 INFO - Using buildbot properties: 00:58:43 INFO - { 00:58:43 INFO - "project": "", 00:58:43 INFO - "product": "firefox", 00:58:43 INFO - "script_repo_revision": "production", 00:58:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:58:43 INFO - "repository": "", 00:58:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:58:43 INFO - "buildid": "20160622000716", 00:58:43 INFO - "pgo_build": "False", 00:58:43 INFO - "basedir": "/builds/slave/test", 00:58:43 INFO - "buildnumber": 1601, 00:58:43 INFO - "slavename": "talos-linux64-ix-052", 00:58:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:58:43 INFO - "platform": "ubuntu64_hw", 00:58:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:58:43 INFO - "branch": "fx-team", 00:58:43 INFO - "repo_path": "integration/fx-team", 00:58:43 INFO - "revision": "0d361d105c86ff3443c06a7387b994d75035178e", 00:58:43 INFO - "stage_platform": "linux64", 00:58:43 INFO - "builduid": "362ce1e45b0d45f6bb162cfd180003ea", 00:58:43 INFO - "slavebuilddir": "test" 00:58:43 INFO - } 00:58:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:58:43 INFO - Running post-action listener: _resource_record_post_action 00:58:43 INFO - ##### 00:58:43 INFO - ##### Finished read-buildbot-config step (success) 00:58:43 INFO - ##### 00:58:43 INFO - ##### 00:58:43 INFO - ##### Running download-and-extract step. 00:58:43 INFO - ##### 00:58:43 INFO - Running pre-action listener: _resource_record_pre_action 00:58:43 INFO - Running main action method: download_and_extract 00:58:43 INFO - mkdir: /builds/slave/test/build/tests 00:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:43 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:58:46 INFO - Downloaded 1361 bytes. 00:58:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:46 INFO - Using the following test package requirements: 00:58:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:58:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:58:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:58:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'jsshell-linux-x86_64.zip'], 00:58:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:58:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:58:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:58:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:58:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:58:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:58:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:46 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:58:54 INFO - Downloaded 22701903 bytes. 00:58:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:58:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:58:56 INFO - Return code: 0 00:58:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:58:56 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')]} 00:58:56 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:58:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:02 INFO - Downloaded 22701903 bytes. 00:59:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:59:03 INFO - Return code: 0 00:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:03 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:59:05 INFO - Downloaded 14405384 bytes. 00:59:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:59:05 INFO - Return code: 0 00:59:05 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')]} 00:59:05 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:59:06 INFO - Downloaded 56236599 bytes. 00:59:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:59:06 INFO - mkdir: /builds/slave/test/properties 00:59:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:59:06 INFO - Writing to file /builds/slave/test/properties/build_url 00:59:06 INFO - Contents: 00:59:06 INFO - build_url:https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:59:07 INFO - Running post-action listener: _resource_record_post_action 00:59:07 INFO - Running post-action listener: set_extra_try_arguments 00:59:07 INFO - ##### 00:59:07 INFO - ##### Finished download-and-extract step (success) 00:59:07 INFO - ##### 00:59:07 INFO - ##### 00:59:07 INFO - ##### Running populate-webroot step. 00:59:07 INFO - ##### 00:59:07 INFO - Running pre-action listener: _resource_record_pre_action 00:59:07 INFO - Running main action method: populate_webroot 00:59:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:59:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:59:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:59:07 INFO - '--tppagecycles', 00:59:07 INFO - '7'], 00:59:07 INFO - 'tests': ['tsvgm']}}, 00:59:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:59:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:59:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:59:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:59:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['damp', 'tps']}, 00:59:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'tests': ['damp', 'tps']}, 00:59:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['dromaeo_dom']}, 00:59:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:59:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['basic_compositor_video']}, 00:59:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:59:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'other-e10s': {'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['a11yr', 00:59:07 INFO - 'ts_paint', 00:59:07 INFO - 'tpaint', 00:59:07 INFO - 'sessionrestore', 00:59:07 INFO - 'sessionrestore_no_auto_restore', 00:59:07 INFO - 'tabpaint']}, 00:59:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['tsvgx', 00:59:07 INFO - 'tsvgr_opacity', 00:59:07 INFO - 'tart', 00:59:07 INFO - 'tscrollx', 00:59:07 INFO - 'cart']}, 00:59:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:59:07 INFO - 'tsvgr_opacity', 00:59:07 INFO - 'tart', 00:59:07 INFO - 'tscrollx', 00:59:07 INFO - 'cart']}, 00:59:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'talos_options': ['--disable-e10s'], 00:59:07 INFO - 'tests': ['tp5o']}, 00:59:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'tests': ['tp5o']}, 00:59:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'talos_options': ['--disable-e10s', 00:59:07 INFO - '--xperf_path', 00:59:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:07 INFO - 'tests': ['tp5n']}, 00:59:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:07 INFO - 'talos_options': ['--xperf_path', 00:59:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:07 INFO - 'tests': ['tp5n']}}, 00:59:07 INFO - 'talos.zip': {'path': '', 00:59:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:59:07 INFO - Running post-action listener: _resource_record_post_action 00:59:07 INFO - ##### 00:59:07 INFO - ##### Finished populate-webroot step (success) 00:59:07 INFO - ##### 00:59:07 INFO - ##### 00:59:07 INFO - ##### Running create-virtualenv step. 00:59:07 INFO - ##### 00:59:07 INFO - Running pre-action listener: _resource_record_pre_action 00:59:07 INFO - Running main action method: create_virtualenv 00:59:07 INFO - Creating virtualenv /builds/slave/test/build/venv 00:59:07 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 00:59:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:59:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:59:07 INFO - Using real prefix '/usr' 00:59:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:59:08 INFO - Installing distribute.............................................................................................................................................................................................done. 00:59:10 INFO - Installing pip.................done. 00:59:10 INFO - Return code: 0 00:59:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:10 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 00:59:10 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 00:59:10 INFO - Using env: {'DISPLAY': ':0', 00:59:10 INFO - 'HOME': '/home/cltbld', 00:59:10 INFO - 'LANG': 'en_US.UTF-8', 00:59:10 INFO - 'LANGUAGE': 'en_US:en', 00:59:10 INFO - 'LOGNAME': 'cltbld', 00:59:10 INFO - 'MAIL': '/var/mail/cltbld', 00:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:10 INFO - 'MOZ_NO_REMOTE': '1', 00:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:10 INFO - 'NO_EM_RESTART': '1', 00:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:10 INFO - 'PWD': '/builds/slave/test', 00:59:10 INFO - 'SHELL': '/bin/bash', 00:59:10 INFO - 'SHLVL': '1', 00:59:10 INFO - 'TERM': 'linux', 00:59:10 INFO - 'TMOUT': '86400', 00:59:10 INFO - 'USER': 'cltbld', 00:59:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:10 INFO - '_': '/tools/buildbot/bin/python'} 00:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:10 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 00:59:10 INFO - Cleaning up... 00:59:10 INFO - Return code: 0 00:59:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:59:10 INFO - Using env: {'DISPLAY': ':0', 00:59:10 INFO - 'HOME': '/home/cltbld', 00:59:10 INFO - 'LANG': 'en_US.UTF-8', 00:59:10 INFO - 'LANGUAGE': 'en_US:en', 00:59:10 INFO - 'LOGNAME': 'cltbld', 00:59:10 INFO - 'MAIL': '/var/mail/cltbld', 00:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:10 INFO - 'MOZ_NO_REMOTE': '1', 00:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:10 INFO - 'NO_EM_RESTART': '1', 00:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:10 INFO - 'PWD': '/builds/slave/test', 00:59:10 INFO - 'SHELL': '/bin/bash', 00:59:10 INFO - 'SHLVL': '1', 00:59:10 INFO - 'TERM': 'linux', 00:59:10 INFO - 'TMOUT': '86400', 00:59:10 INFO - 'USER': 'cltbld', 00:59:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:10 INFO - '_': '/tools/buildbot/bin/python'} 00:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:10 INFO - Downloading/unpacking psutil>=3.1.1 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:59:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:12 INFO - Installing collected packages: psutil 00:59:12 INFO - Running setup.py install for psutil 00:59:12 INFO - building 'psutil._psutil_linux' extension 00:59:12 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 00:59:14 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 00:59:14 INFO - building 'psutil._psutil_posix' extension 00:59:14 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 00:59:14 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 00:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:14 INFO - Successfully installed psutil 00:59:14 INFO - Cleaning up... 00:59:14 INFO - Return code: 0 00:59:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:59:14 INFO - Using env: {'DISPLAY': ':0', 00:59:14 INFO - 'HOME': '/home/cltbld', 00:59:14 INFO - 'LANG': 'en_US.UTF-8', 00:59:14 INFO - 'LANGUAGE': 'en_US:en', 00:59:14 INFO - 'LOGNAME': 'cltbld', 00:59:14 INFO - 'MAIL': '/var/mail/cltbld', 00:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:14 INFO - 'MOZ_NO_REMOTE': '1', 00:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:14 INFO - 'NO_EM_RESTART': '1', 00:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:14 INFO - 'PWD': '/builds/slave/test', 00:59:14 INFO - 'SHELL': '/bin/bash', 00:59:14 INFO - 'SHLVL': '1', 00:59:14 INFO - 'TERM': 'linux', 00:59:14 INFO - 'TMOUT': '86400', 00:59:14 INFO - 'USER': 'cltbld', 00:59:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:14 INFO - '_': '/tools/buildbot/bin/python'} 00:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:59:16 INFO - Installing collected packages: mozsystemmonitor 00:59:16 INFO - Running setup.py install for mozsystemmonitor 00:59:16 INFO - Successfully installed mozsystemmonitor 00:59:16 INFO - Cleaning up... 00:59:16 INFO - Return code: 0 00:59:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:59:16 INFO - Using env: {'DISPLAY': ':0', 00:59:16 INFO - 'HOME': '/home/cltbld', 00:59:16 INFO - 'LANG': 'en_US.UTF-8', 00:59:16 INFO - 'LANGUAGE': 'en_US:en', 00:59:16 INFO - 'LOGNAME': 'cltbld', 00:59:16 INFO - 'MAIL': '/var/mail/cltbld', 00:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:16 INFO - 'MOZ_NO_REMOTE': '1', 00:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:16 INFO - 'NO_EM_RESTART': '1', 00:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:16 INFO - 'PWD': '/builds/slave/test', 00:59:16 INFO - 'SHELL': '/bin/bash', 00:59:16 INFO - 'SHLVL': '1', 00:59:16 INFO - 'TERM': 'linux', 00:59:16 INFO - 'TMOUT': '86400', 00:59:16 INFO - 'USER': 'cltbld', 00:59:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:16 INFO - '_': '/tools/buildbot/bin/python'} 00:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:16 INFO - Downloading/unpacking jsonschema==2.5.1 00:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:59:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:59:18 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 00:59:18 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 00:59:18 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 00:59:18 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 00:59:18 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 00:59:18 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 00:59:19 INFO - Downloading functools32-3.2.3-2.tar.gz 00:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:59:19 INFO - warning: no files found matching '*.txt' 00:59:19 INFO - no previously-included directories found matching 'build' 00:59:19 INFO - no previously-included directories found matching 'dist' 00:59:19 INFO - no previously-included directories found matching '.git*' 00:59:19 INFO - Installing collected packages: jsonschema, functools32 00:59:19 INFO - Running setup.py install for functools32 00:59:19 INFO - warning: no files found matching '*.txt' 00:59:19 INFO - no previously-included directories found matching 'build' 00:59:19 INFO - no previously-included directories found matching 'dist' 00:59:19 INFO - no previously-included directories found matching '.git*' 00:59:19 INFO - Successfully installed jsonschema functools32 00:59:19 INFO - Cleaning up... 00:59:19 INFO - Return code: 0 00:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:19 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:19 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 00:59:19 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 00:59:19 INFO - Using env: {'DISPLAY': ':0', 00:59:19 INFO - 'HOME': '/home/cltbld', 00:59:19 INFO - 'LANG': 'en_US.UTF-8', 00:59:19 INFO - 'LANGUAGE': 'en_US:en', 00:59:19 INFO - 'LOGNAME': 'cltbld', 00:59:19 INFO - 'MAIL': '/var/mail/cltbld', 00:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:19 INFO - 'MOZ_NO_REMOTE': '1', 00:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:19 INFO - 'NO_EM_RESTART': '1', 00:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:19 INFO - 'PWD': '/builds/slave/test', 00:59:19 INFO - 'SHELL': '/bin/bash', 00:59:19 INFO - 'SHLVL': '1', 00:59:19 INFO - 'TERM': 'linux', 00:59:19 INFO - 'TMOUT': '86400', 00:59:19 INFO - 'USER': 'cltbld', 00:59:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:19 INFO - '_': '/tools/buildbot/bin/python'} 00:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:19 INFO - Downloading/unpacking blobuploader==1.2.4 00:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 00:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:59:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:21 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 00:59:22 INFO - Downloading docopt-0.6.1.tar.gz 00:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 00:59:22 INFO - Running setup.py install for blobuploader 00:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:59:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:59:22 INFO - Running setup.py install for requests 00:59:22 INFO - Running setup.py install for docopt 00:59:22 INFO - Successfully installed blobuploader requests docopt 00:59:22 INFO - Cleaning up... 00:59:22 INFO - Return code: 0 00:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:22 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:22 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 00:59:22 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 00:59:22 INFO - Using env: {'DISPLAY': ':0', 00:59:22 INFO - 'HOME': '/home/cltbld', 00:59:22 INFO - 'LANG': 'en_US.UTF-8', 00:59:22 INFO - 'LANGUAGE': 'en_US:en', 00:59:22 INFO - 'LOGNAME': 'cltbld', 00:59:22 INFO - 'MAIL': '/var/mail/cltbld', 00:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:22 INFO - 'MOZ_NO_REMOTE': '1', 00:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:22 INFO - 'NO_EM_RESTART': '1', 00:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:22 INFO - 'PWD': '/builds/slave/test', 00:59:22 INFO - 'SHELL': '/bin/bash', 00:59:22 INFO - 'SHLVL': '1', 00:59:22 INFO - 'TERM': 'linux', 00:59:22 INFO - 'TMOUT': '86400', 00:59:22 INFO - 'USER': 'cltbld', 00:59:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:22 INFO - '_': '/tools/buildbot/bin/python'} 00:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:22 INFO - Running setup.py (path:/tmp/pip-EULKT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:23 INFO - Running setup.py (path:/tmp/pip-Gxwd2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:23 INFO - Running setup.py (path:/tmp/pip-oLZWD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:23 INFO - Running setup.py (path:/tmp/pip-xain7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:23 INFO - Running setup.py (path:/tmp/pip-MvrEC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:23 INFO - Running setup.py (path:/tmp/pip-M__bWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:23 INFO - Running setup.py (path:/tmp/pip-cXxXfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:23 INFO - Running setup.py (path:/tmp/pip-EaM4nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:23 INFO - Running setup.py (path:/tmp/pip-RbCxoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:23 INFO - Running setup.py (path:/tmp/pip-68hcVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:23 INFO - Running setup.py (path:/tmp/pip-la9OTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:23 INFO - Running setup.py (path:/tmp/pip-KLZieg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:23 INFO - Running setup.py (path:/tmp/pip-qKH0r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:23 INFO - Running setup.py (path:/tmp/pip-nl7bRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:24 INFO - Running setup.py (path:/tmp/pip-bYfhzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:24 INFO - Running setup.py (path:/tmp/pip-n37Ze4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:24 INFO - Running setup.py (path:/tmp/pip-rgpAos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:59:24 INFO - Running setup.py install for manifestparser 00:59:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:59:24 INFO - Running setup.py install for mozcrash 00:59:24 INFO - Running setup.py install for mozdebug 00:59:24 INFO - Running setup.py install for mozdevice 00:59:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:59:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:59:24 INFO - Running setup.py install for mozfile 00:59:24 INFO - Running setup.py install for mozhttpd 00:59:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:59:24 INFO - Running setup.py install for mozinfo 00:59:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:59:24 INFO - Running setup.py install for mozInstall 00:59:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Running setup.py install for mozleak 00:59:25 INFO - Running setup.py install for mozlog 00:59:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Running setup.py install for moznetwork 00:59:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Running setup.py install for mozprocess 00:59:25 INFO - Running setup.py install for mozprofile 00:59:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Running setup.py install for mozrunner 00:59:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Running setup.py install for mozscreenshot 00:59:25 INFO - Running setup.py install for moztest 00:59:25 INFO - Running setup.py install for mozversion 00:59:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:59:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:59:25 INFO - Cleaning up... 00:59:26 INFO - Return code: 0 00:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:26 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')]} 00:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 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')]} 00:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:26 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:26 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 00:59:26 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 00:59:26 INFO - Using env: {'DISPLAY': ':0', 00:59:26 INFO - 'HOME': '/home/cltbld', 00:59:26 INFO - 'LANG': 'en_US.UTF-8', 00:59:26 INFO - 'LANGUAGE': 'en_US:en', 00:59:26 INFO - 'LOGNAME': 'cltbld', 00:59:26 INFO - 'MAIL': '/var/mail/cltbld', 00:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:26 INFO - 'MOZ_NO_REMOTE': '1', 00:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:26 INFO - 'NO_EM_RESTART': '1', 00:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:26 INFO - 'PWD': '/builds/slave/test', 00:59:26 INFO - 'SHELL': '/bin/bash', 00:59:26 INFO - 'SHLVL': '1', 00:59:26 INFO - 'TERM': 'linux', 00:59:26 INFO - 'TMOUT': '86400', 00:59:26 INFO - 'USER': 'cltbld', 00:59:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:26 INFO - '_': '/tools/buildbot/bin/python'} 00:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:26 INFO - Running setup.py (path:/tmp/pip-pA7aKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:26 INFO - Running setup.py (path:/tmp/pip-cSD5BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:26 INFO - Running setup.py (path:/tmp/pip-qJjRNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:26 INFO - Running setup.py (path:/tmp/pip-bRjQ1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:26 INFO - Running setup.py (path:/tmp/pip-R3JnhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:26 INFO - Running setup.py (path:/tmp/pip-t9Hhho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:26 INFO - Running setup.py (path:/tmp/pip-t0AaEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:26 INFO - Running setup.py (path:/tmp/pip-5hmmMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:26 INFO - Running setup.py (path:/tmp/pip-BDbK13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:26 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:26 INFO - Running setup.py (path:/tmp/pip-W4q_3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 00:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:26 INFO - Running setup.py (path:/tmp/pip-Q54nl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:27 INFO - Running setup.py (path:/tmp/pip-sP_oHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:27 INFO - Running setup.py (path:/tmp/pip-k5e79p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:27 INFO - Running setup.py (path:/tmp/pip-RpQGJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:27 INFO - Running setup.py (path:/tmp/pip-p1Ujzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:27 INFO - Running setup.py (path:/tmp/pip-mHEABJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:27 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)) 00:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:27 INFO - Running setup.py (path:/tmp/pip-m8KWz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:27 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)) 00:59:27 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)) 00:59:27 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)) 00:59:27 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)) 00:59:27 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)) 00:59:27 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)) 00:59:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:27 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 00:59:29 INFO - Downloading blessings-1.6.tar.gz 00:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:59:29 INFO - Installing collected packages: blessings 00:59:29 INFO - Running setup.py install for blessings 00:59:29 INFO - Successfully installed blessings 00:59:29 INFO - Cleaning up... 00:59:29 INFO - Return code: 0 00:59:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:29 INFO - Reading from file tmpfile_stdout 00:59:29 INFO - Current package versions: 00:59:29 INFO - argparse == 1.2.1 00:59:29 INFO - blessings == 1.6 00:59:29 INFO - blobuploader == 1.2.4 00:59:29 INFO - docopt == 0.6.1 00:59:29 INFO - functools32 == 3.2.3-2 00:59:29 INFO - jsonschema == 2.5.1 00:59:29 INFO - manifestparser == 1.1 00:59:29 INFO - mozInstall == 1.12 00:59:29 INFO - mozcrash == 0.17 00:59:29 INFO - mozdebug == 0.1 00:59:29 INFO - mozdevice == 0.48 00:59:29 INFO - mozfile == 1.2 00:59:29 INFO - mozhttpd == 0.7 00:59:29 INFO - mozinfo == 0.9 00:59:29 INFO - mozleak == 0.1 00:59:29 INFO - mozlog == 3.2 00:59:29 INFO - moznetwork == 0.27 00:59:29 INFO - mozprocess == 0.22 00:59:29 INFO - mozprofile == 0.28 00:59:29 INFO - mozrunner == 6.11 00:59:29 INFO - mozscreenshot == 0.1 00:59:29 INFO - mozsystemmonitor == 0.3 00:59:29 INFO - moztest == 0.7 00:59:29 INFO - mozversion == 1.4 00:59:29 INFO - psutil == 3.1.1 00:59:29 INFO - requests == 1.2.3 00:59:29 INFO - wsgiref == 0.1.2 00:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:29 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:29 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 00:59:29 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 00:59:29 INFO - Using env: {'DISPLAY': ':0', 00:59:29 INFO - 'HOME': '/home/cltbld', 00:59:29 INFO - 'LANG': 'en_US.UTF-8', 00:59:29 INFO - 'LANGUAGE': 'en_US:en', 00:59:29 INFO - 'LOGNAME': 'cltbld', 00:59:29 INFO - 'MAIL': '/var/mail/cltbld', 00:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:29 INFO - 'MOZ_NO_REMOTE': '1', 00:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:29 INFO - 'NO_EM_RESTART': '1', 00:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:29 INFO - 'PWD': '/builds/slave/test', 00:59:29 INFO - 'SHELL': '/bin/bash', 00:59:29 INFO - 'SHLVL': '1', 00:59:29 INFO - 'TERM': 'linux', 00:59:29 INFO - 'TMOUT': '86400', 00:59:29 INFO - 'USER': 'cltbld', 00:59:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:29 INFO - '_': '/tools/buildbot/bin/python'} 00:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 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)) 00:59:30 INFO - Cleaning up... 00:59:30 INFO - Return code: 0 00:59:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:30 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:30 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 00:59:30 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 00:59:30 INFO - Using env: {'DISPLAY': ':0', 00:59:30 INFO - 'HOME': '/home/cltbld', 00:59:30 INFO - 'LANG': 'en_US.UTF-8', 00:59:30 INFO - 'LANGUAGE': 'en_US:en', 00:59:30 INFO - 'LOGNAME': 'cltbld', 00:59:30 INFO - 'MAIL': '/var/mail/cltbld', 00:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:30 INFO - 'MOZ_NO_REMOTE': '1', 00:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:30 INFO - 'NO_EM_RESTART': '1', 00:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:30 INFO - 'PWD': '/builds/slave/test', 00:59:30 INFO - 'SHELL': '/bin/bash', 00:59:30 INFO - 'SHLVL': '1', 00:59:30 INFO - 'TERM': 'linux', 00:59:30 INFO - 'TMOUT': '86400', 00:59:30 INFO - 'USER': 'cltbld', 00:59:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:30 INFO - '_': '/tools/buildbot/bin/python'} 00:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:59:30 INFO - Cleaning up... 00:59:30 INFO - Return code: 0 00:59:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:30 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 0x7ffebfd63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, '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': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', '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 00:59:30 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 00:59:30 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 00:59:30 INFO - Using env: {'DISPLAY': ':0', 00:59:30 INFO - 'HOME': '/home/cltbld', 00:59:30 INFO - 'LANG': 'en_US.UTF-8', 00:59:30 INFO - 'LANGUAGE': 'en_US:en', 00:59:30 INFO - 'LOGNAME': 'cltbld', 00:59:30 INFO - 'MAIL': '/var/mail/cltbld', 00:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:30 INFO - 'MOZ_NO_REMOTE': '1', 00:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:30 INFO - 'NO_EM_RESTART': '1', 00:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:30 INFO - 'PWD': '/builds/slave/test', 00:59:30 INFO - 'SHELL': '/bin/bash', 00:59:30 INFO - 'SHLVL': '1', 00:59:30 INFO - 'TERM': 'linux', 00:59:30 INFO - 'TMOUT': '86400', 00:59:30 INFO - 'USER': 'cltbld', 00:59:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:30 INFO - '_': '/tools/buildbot/bin/python'} 00:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:30 INFO - Downloading/unpacking flake8 00:59:30 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 00:59:30 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 00:59:30 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 00:59:30 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 00:59:30 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 00:59:30 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 00:59:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:59:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:59:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:32 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 00:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:59:33 INFO - no previously-included directories found matching 'docs/_build' 00:59:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:59:33 INFO - Running setup.py install for pep8 00:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:59:33 INFO - no previously-included directories found matching 'docs/_build' 00:59:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:59:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:59:33 INFO - Cleaning up... 00:59:33 INFO - Return code: 0 00:59:33 INFO - Running post-action listener: _resource_record_post_action 00:59:33 INFO - Running post-action listener: _start_resource_monitoring 00:59:33 INFO - Starting resource monitoring. 00:59:33 INFO - ##### 00:59:33 INFO - ##### Finished create-virtualenv step (success) 00:59:33 INFO - ##### 00:59:33 INFO - ##### 00:59:33 INFO - ##### Running install step. 00:59:33 INFO - ##### 00:59:33 INFO - Running pre-action listener: _resource_record_pre_action 00:59:33 INFO - Running main action method: install 00:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:33 INFO - Reading from file tmpfile_stdout 00:59:33 INFO - Detecting whether we're running mozinstall >=1.0... 00:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:59:33 INFO - Reading from file tmpfile_stdout 00:59:33 INFO - Output received: 00:59:33 INFO - Usage: mozinstall [options] installer 00:59:33 INFO - Options: 00:59:33 INFO - -h, --help show this help message and exit 00:59:33 INFO - -d DEST, --destination=DEST 00:59:33 INFO - Directory to install application into. [default: 00:59:33 INFO - "/builds/slave/test"] 00:59:33 INFO - --app=APP Application being installed. [default: firefox] 00:59:33 INFO - mkdir: /builds/slave/test/build/application 00:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:59:50 INFO - Reading from file tmpfile_stdout 00:59:50 INFO - Output received: 00:59:50 INFO - /builds/slave/test/build/application/firefox/firefox 00:59:50 INFO - Running post-action listener: _resource_record_post_action 00:59:50 INFO - ##### 00:59:50 INFO - ##### Finished install step (success) 00:59:50 INFO - ##### 00:59:50 INFO - ##### 00:59:50 INFO - ##### Running run-tests step. 00:59:50 INFO - ##### 00:59:50 INFO - Running pre-action listener: _resource_record_pre_action 00:59:50 INFO - Running main action method: run_tests 00:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:59:50 INFO - Python 2.7.3 00:59:50 INFO - Return code: 0 00:59:50 INFO - grabbing minidump binary from tooltool 00:59:50 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')]} 00:59:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a1c0>, '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 0x255b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:59:50 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 00:59:50 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 00:59:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:59:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:59:50 INFO - Return code: 0 00:59:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:59:51 INFO - Return code: 0 00:59:51 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 00:59:51 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 00:59:51 INFO - Using env: {'DISPLAY': ':0', 00:59:51 INFO - 'HOME': '/home/cltbld', 00:59:51 INFO - 'LANG': 'en_US.UTF-8', 00:59:51 INFO - 'LANGUAGE': 'en_US:en', 00:59:51 INFO - 'LOGNAME': 'cltbld', 00:59:51 INFO - 'MAIL': '/var/mail/cltbld', 00:59:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:59:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:51 INFO - 'MOZ_NO_REMOTE': '1', 00:59:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:51 INFO - 'NO_EM_RESTART': '1', 00:59:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:51 INFO - 'PWD': '/builds/slave/test', 00:59:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:59:51 INFO - 'SHELL': '/bin/bash', 00:59:51 INFO - 'SHLVL': '1', 00:59:51 INFO - 'TERM': 'linux', 00:59:51 INFO - 'TMOUT': '86400', 00:59:51 INFO - 'USER': 'cltbld', 00:59:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834', 00:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:51 INFO - '_': '/tools/buildbot/bin/python'} 00:59:51 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 00:59:51 INFO - mozversion application_buildid: 20160622000716 00:59:51 INFO - mozversion application_changeset: 0d361d105c86ff3443c06a7387b994d75035178e 00:59:51 INFO - mozversion application_display_name: Nightly 00:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:59:51 INFO - mozversion application_name: Firefox 00:59:51 INFO - mozversion application_remotingname: firefox 00:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:59:51 INFO - mozversion application_vendor: Mozilla 00:59:51 INFO - mozversion application_version: 50.0a1 00:59:51 INFO - mozversion platform_buildid: 20160622000716 00:59:51 INFO - mozversion platform_changeset: 0d361d105c86ff3443c06a7387b994d75035178e 00:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:59:51 INFO - mozversion platform_version: 50.0a1 00:59:51 INFO - using testdate: 1466582391 00:59:51 INFO - actual date: 1466582391 00:59:51 INFO - starting webserver on 'localhost:38651' 00:59:51 INFO - SUITE-START | Running 2 tests 00:59:51 INFO - TEST-START | dromaeo_css 00:59:51 INFO - operating with platform_type : linux_ 00:59:51 INFO - Initialising browser for dromaeo_css test... 00:59:51 INFO - TEST-INFO | started process 3337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoeDTn/profile http://localhost:38651/getInfo.html) 00:59:58 INFO - PROCESS | 3337 | __metrics Screen width/height:1600/1200 00:59:58 INFO - PROCESS | 3337 | colorDepth:24 00:59:58 INFO - PROCESS | 3337 | Browser inner width/height: 1024/697 00:59:58 INFO - PROCESS | 3337 | __metrics 00:59:59 ERROR - PROCESS | 3337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:00:00 INFO - TEST-INFO | 3337: exit 0 01:00:00 INFO - Browser initialized. 01:00:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:00:00 INFO - TEST-INFO | started process 3457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoeDTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:00:12 INFO - PROCESS | 3457 | RSS: Main: 186019840 01:00:12 INFO - PROCESS | 3457 | 01:01:02 INFO - PROCESS | 3457 | 1466582462166 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] 01:03:14 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38651/tests/dromaeo/cssquery-ext.html) 01:03:15 INFO - PROCESS | 3457 | RSS: Main: 189153280 01:03:15 INFO - PROCESS | 3457 | 01:06:17 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-ext.html (next: http://localhost:38651/tests/dromaeo/cssquery-jquery.html) 01:06:18 INFO - PROCESS | 3457 | RSS: Main: 188178432 01:06:18 INFO - PROCESS | 3457 | 01:09:20 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38651/tests/dromaeo/cssquery-mootools.html) 01:09:20 INFO - PROCESS | 3457 | RSS: Main: 189452288 01:09:20 INFO - PROCESS | 3457 | 01:12:22 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38651/tests/dromaeo/cssquery-prototype.html) 01:12:23 INFO - PROCESS | 3457 | RSS: Main: 186929152 01:12:23 INFO - PROCESS | 3457 | 01:15:25 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38651/tests/dromaeo/cssquery-yui.html) 01:15:26 INFO - PROCESS | 3457 | RSS: Main: 189259776 01:15:26 INFO - PROCESS | 3457 | 01:18:28 INFO - PROCESS | 3457 | Cycle 1(1): loaded http://localhost:38651/tests/dromaeo/cssquery-yui.html (next: http://localhost:38651/tests/dromaeo/cssquery-dojo.html) 01:18:29 INFO - PROCESS | 3457 | RSS: Main: 190251008 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | __start_tp_report 01:18:29 INFO - PROCESS | 3457 | _x_x_mozilla_page_load 01:18:29 INFO - PROCESS | 3457 | _x_x_mozilla_page_load_details 01:18:29 INFO - PROCESS | 3457 | |i|pagename|runs| 01:18:29 INFO - PROCESS | 3457 | |0;dojo.html;2642.1809239135864;2691.6231727558134;2694.030149146307;2701.797365197608;2711.1730922068773;4784.40194975628;4801.687890287133;4829.613630909527;4886.975565122169;4946.431160416553;4801.087793319267;4883.975580122104;4914.410270767504;4946.530079642428;4956.083124621948;4474.753888536129;4523.8642840714665;4615.26155815068;4622.329762184481;4650.116477869211;369.60142364992805;4398.494173170095;4407.118576284756;4494.865154045384;4545.659075569329;4425.314076318144;4430.867073987785;4441.955580444186;4464.218761716719;4507.842225522124;4420.40324556184;4453.064856380164;4470.351798989161;4487.865364039084;4507.729536227836;4375.781210939472;4450.020995381011;4453;4499.235130027871;4506.752128632924;4852.830150944736;4914.70511769295;4933.654644174909;4958.528939750718;5005.27423523587;5274.393444753864;5327.813526526592;5345.198220266952;5354.598405119632;5396.298481197458;5329.360476742777;5377.11277639189;5380.5964552658315;5390.6226564140525;5437.646552974044;4987.877727511281;4988.825391111293;4990.451050384455;5015.423226329019;5039.395272567315;5220.582353411718;5327.893442131136;5342.732863356817;5345.705986170798;5360.410354860962;5176.378834539879;5186.92219616706;5193.195054766517;5201.895962080737;5244.842654720364;5275.182346736262;5284.788608455696;5288.471152884757;5295.814646487354;5344.518993290622;5054.09026375256;5183.688978661293;5212.218167274939;5229.555487783505;5240.135377662719;5220.869478262998;5231.450697676689;5252.947470525322;5253.238280449314;5272.762725677354;4425.070735145591;4425.668074894395;4426.756528390905;4456.866294011184;4470.821167153277;3779.640934111255;3779.6787273082095;3817.7136714746507;3850.210706805098;3856.7300288980064;4407.933880991788;4424.75663838492;4437.866863994085;4468.352088947085;4495.842645507391;5255;5276.129438642658;5278.340207474066;5286.207068939613;5324.8136315228785;4405.074934263776;4499;4509.977450112729;4546.590806827401;4567.611753000966;4792.161371759928;4792.880177995578;4805.495422980537;4807.975960120247;4858.6356023298395;4895.363602731622;4969.229769385751;4987.80048798044;4988.201887697878;5030.949690503048;5066.03745288394;5221;5234.842954711365;5248.3701955765555;5256.053910296183;4879.902401952012;4880.731559764105;4902.117618828503;4919;4944.456109827845;5090.0583392072585;5193.662411943212;5193.896122077462;5205.427402985744;5217.373915130209;5249.580033597379;5259.947400525945;5295.735213239245;5306.6550674206055;5333.599980001438;5164.845054648366;5167.974160129175;5181.093308670892;5184.507471790174;5211.5049070338255;4931.753412329297;4966.6771659842;5160.225966104964;5172.870678233075;5178.300929374486;4981.6014718823135;4992.900141997213;4995.725235112103;5001.974990125026;5071.0872043032605;5175.0167468180925;5180.6891586503425;5182.300389447376;5190.688558686491;5223.21651752225;4885.5847252983895;4983.202687569971;5063.26582645507;5066.240063990431;5068.163752980717 01:18:29 INFO - PROCESS | 3457 | |1;ext.html;536.6866455125945;578.7424596054755;588.5115354255967;599.7960693364255;607.5504126946059;34182;34726.8263658682;34782.30435391291;34862.477062844046;34959.65040349593;38708.61291387085;39085.8045709771;39208.803955980184;39419.60580394195;39474.80262598683;7689.846203075949;7819.804504887366;7826.334761545247;7835.960820195891;7862.292393684567;7799.805004874866;7859.607019649024;7891.802704932394;7905.367570594339;7910.644021019068;7838.568878711669;7919.604019799016;7939.880901786478;7947;7955.284024437799;7847.6468558914985;7858.135605083407;7874.133845277015;7875.527468351917;7914.3272821810215;7849.254320839568;7852.607369631495;7900.091489478668;7902.723404680809;7917.2874441300555;38584.80707596444;38604;38883.416748748794;38888.80555597232;39004.804975975225;3145.496720524728;3259.103746469716;3357.61387440445;3539.327527769741;3785.6971442284553;29319.85340073286;29698;29773;29828.10515684533;31022;3342.8829990950444;3357.6474470180524;3369.275605744777;3383.069655844638;3454.4300190468543;243576;243934;244294;244569;245769;28890.711092888803;29862.701372986427;29864;54314.728426357615;54997.725011374685;32842.67157328396;33013.50479742806;33031.33937321288;33047.17382065419;33074.503882441786;13120.671983200496;13249.13880597758;13308.467661293633;13357;13388.129771564818;11714.297142171497;11763.529458821722;11785.410729463492;11806.94096529529;11857.229280096766;7878.1334053254095;7913.841723165505;8000;8000.5599692017495;8038.758837234892;3083.8149711016963;3178.2372230664473;3207.5830142081845;3219.9839000805314;3227.7095061444584;856.118198255785;859.3640705877606;866.8309679612415;932.958016889228;936.8196072948134;28137.43725125486;28546.857265713956;28801.567976480368;29205.123846284645;29572;844.3751623798468;870.2037635563389;909.8043920557112;935.6678379175431;1024.7899180667946;14646.048006879519;14761.188134652482;14813;15112.622184445258;15282.770758438632;373199;375462;377328;377866;380091;51098.23352649713;51667.2249916244;51670;51711.74144129255;52022.47977520252;1156.7859945910034;1179.9056075513938;1197.8143387774908;1197.886200810939;1201.9038476921826;26828.731712682624;28031.579526306712;28162.85918570394;28509.857450712614;28580.14259572216;43350.78324608483;43582.346264806685;43815;43879;43976.34035489534;314749;315766;316167;316853;317350;25773.226803195936;25992.610110847974;26189.476210475303;26804.06185783488;26818.195454136407;43035.569644303156;43343.78328108339;43730.78134609306;43980.34029489496;44335.334969976124;37099.44350834793;37398.06504837292;37460.250794984495;37517;38133.809330954275;34583.30833383369;36509.817450912575;36711.63288367082;37055.814720926224;37286.62713372832;36288.81855590705;36393.272134557694;36767.63232367642;37117.81441092777;37121.21590880641;32516.34967300688;33581.664183357854;33646.495302569994;34053.82973085119;34062.31875362429;25648.23055308344;25693.35766605775;25874.44753314807;25885.352866178495;26033.869830650725 01:18:29 INFO - PROCESS | 3457 | |2;jquery.html;366.7322854316349;369.87054530914185;376.0936143893217;379.27369088196104;389.92786334528097;15884.126373049477;16363.590910227236;16957.49127526176;16964.236609352578;16991.150442477858;15895.92052039741;16534;16819.32722691094;16847.578810529743;16871.746923796152;5103.209002604603;5265.526102650761;5309.044372013036;5313.256144139824;5313.495217954288;3775.697944164474;5225.242339860718;5776.422357764232;6138.109974053759;6144.678894037781;6166.4450199482035;6173.506119510451;6184.25788905332;6185.257769067695;6216.316205217422;5067.974660126694;5379.542738867201;5392.514673679388;5461.863453413656;5477.260569823063;5230.8692282692855;5270.130428479296;5297.841064768063;5360.3299587551555;5376.193570964348;11640.06879449642;11845.466953987092;11897.405129743565;19660.606787864304;19941.700874486894;1853.9907300463547;2082.7500699915954;2120.5758848230416;2125.0649714125734;2371.5019845832394;8697.95651021741;9203.493807840567;9251.213646840026;9434.95282523583;9586.424814511152;1721.1394302848576;1779.2616064333286;1845.796962334142;1855.7958624551425;1871.7192421136801;59853.7007314965;60658.69670651619;67134;67946.66026669835;71312.28687713109;9830.4101753895;10192.541335639915;10313.9484302578;10406.947965260126;10497.737556561147;13681.657958551115;13981.930090349482;14012.579622611338;14064;14080.788788168185;7276.038161592953;7743.225677432211;7857.646405911748;7884.605769711491;7958.442908996315;7632.3512501438;7733.8453230935065;7764.728234511765;7783.766487005399;7786.7663970080985;4272.252355837716;4349.391085248068;4363.345498175299;4519.0961807638605;4529.230030894756;1676.8574671152844;1704.991475042617;1724.3792234795465;1830.9816901831077;1894.327513732605;831.3100126894662;882.6601758322963;941.1294552538874;964.9517524123765;980.6861804222723;16098.75851862223;16814.663706725798;16917.49247522576;16982.065986370868;17309.826901731074;826.2646244842095;873.6592728835759;874.8512752832033;883.412530667112;889.8131392407666;9122.315826313054;9252.398594091363;9714.514274286257;10075.193984481224;10182;369829;375258;377118;377395;379941;68291;72518.63740681263;74731;82898;86456;893.2318206342541;910.3081657939881;917.3303488453466;935.504182783126;941.7410212191702;16270.755938661167;16342.836571634132;16382.918085409498;16433.424830130887;16508.83491165073;38211;38313.61686383212;38591.6140838588;39163.41254881122;41049.589504105774;53615;55049.44950550603;55281.447185529236;55661;56133.15800263081;7591.544507329357;7778.688852445839;7845.293923546908;7917.089534703583;7924.366050715814;8293.087760346236;8306.086330503518;8501.362397820065;8520.318374530147;8623.223909848144;7385.5937923412575;7584.241575842371;7718.8544224057905;7767.961160194162;8029.7189598363775;7759.495632783851;7889.723859664884;7899.210078992055;7930.881036784568;8048.774418315292;7339.449541284532;7672.271134242238;7735.6905723770415;7808.297253247235;8091.029076510621;11257.15571332137;11635.127365447455;11784.646460606196;11788.528458861892;12039.097067720131;10506.579736810441;10901.295703142352;10965.451727413756;11015;11280.774384512428 01:18:29 INFO - PROCESS | 3457 | |3;mootools.html;1373.5329987804143;1410.8730214280715;1482.1699848085073;1651.8265582113886;1657.1631326180277;6857.691403886824;7598;7604.847903041936;8152.91847081529;8154.225348591882;7655.540667559951;7884.566348850811;7928.841423171548;7985.281324680777;7991.600419978992;2176.455886028493;2222.122261706625;2222.7777222277805;2223.188536184289;2232.006756993139;2170.8046275835172;2201.9210586812505;2234.084025549525;2237.6196046672026;2237.7874101960288;2211.7124773779465;2216.293454040388;2222.3221917315213;2228.5097278598764;2234.441389652587;2150.903209355583;2156.450105223166;2158.136745301876;2168.609650262952;2170.197027099975;2179.9128034878586;2207.8564893282046;2210.8341874359326;2222.411061068818;2224.655178447327;7909.406794490436;7952.125266220711;7986.2013798620255;7987.760367188994;8014.358851291941;4507.346434766941;4617.607503362218;4627.23650597651;4648.883777905579;4650.581447669726;2872.1261711795046;2947.263184203949;2947.5873377727135;3017.8038427502142;3020.3053297741644;934.7896723237217;965.9275554333383;980.3333733061515;983.4148681534475;988.5403287471361;10746.570137194582;10922.235443518957;10934.890651093467;10955.890441095567;10957.671269861918;4136.937945930814;4168.083021735213;4280.07978284664;4283.571642835692;4333.458317710286;9317.813643727088;9346.626134954662;9369.531523423802;9375.10936461035;9380.95309523448;4609.354690343354;4646.442426908725;4666.929996050062;4680.297955306663;4700.88247793801;3793.7344385893275;4158.6673066154635;4174.812133454002;4315.913681726348;4324.762138082373;3689.5572531296416;3760.7931563764255;3798.7150963677836;3815.3323168445413;3899.3566061599518;1183.674489515373;1189.4469071881617;1199.9820002699967;1204.5181927229178;1212.7331986962854;802.4222559756965;810.8041379650913;839.7010664203427;843.843888880559;852.5311078906576;5272.393674727378;5685.687287199244;5697.059985102412;5718.1136923776885;5804.2744656917885;843.7131375332416;859.2352806002663;867.4101610904519;911.4850109688005;916.2715641065369;3789.223209242154;3812.1803812180515;3894.4353068804867;3913.8043097844993;3916.5691773904846;9263.95368023169;9538.3323167379;9637.18083962857;9645.855312170323;9657.565409556586;9426.95286523563;9465.90534094664;9472.431654100637;9481.573329200202;9521;7432.62836858155;7441.813954651068;7455.4035677146785;7555.13115991668;7571.46999710015;5598.776048958159;5601.887962240651;5602.5517958562405;5677.858053548694;5812.360640329476;9050;9074;9092.181703646704;9192.540372981457;9271.582778774837;8864;9156.725298241063;9166.266698664223;9197.31020173503;9224.169824715807;5898.115282707457;6350.015747559136;6519.250286217146;6626.768063117768;6629.303923088007;7586.089669239726;7621.1997740236475;7647.235276472308;7659.961700191463;7675.155732869268;6681.498887583353;6902.482313826383;6920.273371296143;7038.260982596754;7057.682404291922;6783.762568310085;6786.830329241809;6901.102856628606;7012.614306213003;7024.1571011478945;6371.458426033839;6392.0411938209645;6425.518086143651;6430.067640192053;6503.122078519339;4243.724157929724;4259.531451540266;4320.179165958458;4341.283688191413;4349.782510874507;4622.86131416058;4670.673052886265;4699.953000469952;4705.8352957647685;4711.269753188124 01:18:29 INFO - PROCESS | 3457 | |4;prototype.html;300.51916932907346;306.8281762213161;307.3576225688312;311.6696301919965;313.7270574600098;5032.924506132402;5040.445550989393;5045.369328833895;5077.466865979074;5113.156329205676;4952.603791696655;4972.751362431882;4976.755811047238;4996.67521611095;5046.192609182532;3714.349988751971;3812.5043744313202;3935.7835319057585;3944.467496887912;3969.563348031714;3958.2677204717074;3969.6030396960364;3972.5500192429845;3978.3037968355566;3983.302921988655;3952.2688302663955;3965.662918651918;3982.203559288154;3988.34192358262;3990.2817492851277;3822.140018495844;3928;3928.1750832325247;3961.8019099045077;3985.3424185009585;3490.3542844573835;3515.6660117288816;3523.5243242162237;3536.257385948954;3536.974277459534;4879.316895634614;4930.876728081791;4937.938343256181;4955.126026904423;4962.280469331963;4401.106734289412;4546;4558.566936141061;4563.06457176278;4564.109998550251;5250.553702935255;5256.553192978601;5269.789208431658;5272.182811664198;5278.630495865291;3841.2355891226753;3859.6912247020173;3866.0528170598104;3872.9031774205587;3879.9030024249337;5354.43778403266;5542.558934676973;5570.387257401682;5570.498655121059;5575.665460072409;3880.825362858678;3882.5729169791302;3883;3888.2223555289056;3897.824597893102;3928.9214215716097;3956.841726330972;3972.741771784825;3973.562908080109;3977.423273625308;4495.325701144854;4501.6848820582245;4506.684532082788;4509.6392288616835;4535.614472769786;5184;5314.070037743457;5329.108166600801;5330.307060082242;5345.171498417673;1391.9652008699863;1401.8878489721;1407.331517529186;1408.7464256433736;1409.443269908401;860.9182127697984;886.3308202307217;893.3657103456488;905.9773505662412;912.2519533982204;4519.367288579601;4647.442306923191;4652.534746525388;4657.650676199299;4672.719636821802;5400.108982017923;5421.810236641778;5429.239906413105;5474.671519708831;5500.009998200282;4453.105481437092;4630.166570017429;4641.052931388593;4641.118187544424;4647.930281045787;2880.683124856264;2923.5906973023793;2926.824390536575;2928.3264849084403;2928.3996780659913;5055.368078990126;5085.262636917626;5125.4874512549195;5134.178531434953;5139.357580302462;5433.592480563894;5493.176023596492;5516.834494965157;5634.3802181759975;5662.556048207681;5123.257127716461;5133.666311689728;5135.255387968724;5160.845174644692;5175.990681817085;5422.891542169214;5428.809991650273;5482.39693633692;5490.835274941758;5561.138023606348;5165.225216217447;5396.163594642837;5400.594955378441;5470.562355011669;5480.588955828249;5107.514786095315;5136.563392111563;5166.689998600096;5189.054104710734;5215.348081489814;3839.827207775601;3853.8651147210835;3867.563435035909;3883.5339759229073;3886.8833934981994;5172.922406163986;5463.453654634504;5483.150111732688;5512.173174023928;5515.145152501369;5303.329451222852;5303.840884773463;5346.652467589594;5374.4625537445945;5397.217403476396;5149.775535338304;5312.362516498045;5363.383210930793;5368.1679339702405;5399.622026458111;5225.372955245395;5244.213367994831;5245.790168393374;5256.554447526961;5257.8695580450385;5195.168772996302;5225.973870130625;5369.4093649697725;5403.621746477709;5419.132938729785;5168.198929165986;5233.555147812479;5262.26328314044;5263.973680131575;5318.255444237887 01:18:29 INFO - PROCESS | 3457 | |5;yui.html;683.781190019194;722.6350692900081;725.5682868693127;731.2102928836857;740.2264633458036;11594.884051159486;12360.690982725437;12473.37633118344;12762.36188190589;13254.271015094166;13698.794518082237;13701.3834377453;13719.451221951134;13789.448422063131;13886.305684715775;626.4675026227716;784.4391260248921;797.3063434811708;806.9993208421545;807.5881300536739;807.4711064252895;809.8987626546682;812.1675282835112;814.250889181954;816.0411516468156;846.6571038729294;848.499385362636;848.5629900601195;849.218718778722;850.3919697416346;832.063928080909;833;833.8874251975997;836.5984327522823;836.6527890925258;610.3896103896104;613.8281281241215;615.4799194680488;615.8152554233712;616.1866336435907;12576.68558286041;12662.81005784914;12667.429965651569;12689.36553172347;12693;14083.155010699391;14254;14343.85656143446;14511.274436278143;14517.274136293143;10632.415217163052;10862.02241798242;10885.292455990415;10939.343639381663;10977.506012229469;3250.3509639643617;3376.9493457598155;3397.541331920184;3424.8116353600544;3524.4184709522897;61384;61759;61826;61940;62623.6868815653;10603.681889543326;10638.840417393745;10641;10702.73243168927;10757.246992710436;19858.50353741139;19861.30485433003;19861.404157875288;19934.60130797376;20100.396988090382;6543.770968016097;6553.91860343038;6662.200535935719;6669.933300666931;6740.325967403319;3561.30554541867;3565.5721313442555;3583.8924832255075;3622.873199438007;3647.908802279911;2745.6156138140677;2833.617461642652;2838.460692468466;2846.658400991853;2858.757005654501;535.1571275241432;542.3085565903505;542.6608369768894;547.8329109621524;555.4473299067373;497.29632569913167;509.77315094783205;524.9763760630781;528.3395755305868;563.6449037106596;8021.398395120389;8085.3531717462465;8098.392620553482;8179.754607361789;8237.423380363436;556.4908109080146;568.2130249604328;580.7996241296746;585.9560532960045;587.5974957154363;3678.1540245743627;3749.718771092179;3781.3193625147737;3887.5140607424073;3913.373860182357;54130;54439;54637.72681136569;96507.51746241364;97527.51236243773;47623.28565071527;48062.279065814044;48818;55503.72248138733;78720;43585;45122.09755804931;46764.532354676696;52574;73288.63355683294;7071.611061391673;7175.282471752783;7210.206877243394;7217.33746130031;7294.671739771829;44109;45009.32486012647;45447.545524545654;45803.77098114488;46092.769536152104;61955;63861;64269;64301.03548446683;64431.67784161049;10140.898591014291;10156.26165250553;10228.335158214692;10466.895331046897;10561.524731386953;10772.138228941823;10864.402457864893;10932.363954627646;11304.095672346357;11343.20597558163;9952.303338766216;10036.899631003596;10118;10190.082892539707;10228.079472847181;10321.690349289533;10341.586336546454;10448.52981615814;10495.52770125331;10907.127429805438;10333.793324133625;10351.68944931623;11688.70778230551;11897.524099035942;12717.682057948625;10199.28604997643;10313.587456501657;10442.582296708046;10522.894771052192;11235.073607904536;10350.585976560853;10551.525181366704;10609.522571484147;10741.355518668905;10782.838257425989 01:18:29 INFO - PROCESS | 3457 | __end_tp_report 01:18:29 INFO - PROCESS | 3457 | __start_cc_report 01:18:29 INFO - PROCESS | 3457 | _x_x_mozilla_cycle_collect,381 01:18:29 INFO - PROCESS | 3457 | __end_cc_report 01:18:29 INFO - PROCESS | 3457 | __startTimestamp1466583509131__endTimestamp 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | ------- Summary: start ------- 01:18:29 INFO - PROCESS | 3457 | Number of tests: 6 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#0] dojo.html Cycles:165 Average:4826.73 Median:4987.88 stddev:635.47 (12.7%) stddev-sans-first:613.87 01:18:29 INFO - PROCESS | 3457 | Values: 2642.2 2691.6 2694.0 2701.8 2711.2 4784.4 4801.7 4829.6 4887.0 4946.4 4801.1 4884.0 4914.4 4946.5 4956.1 4474.8 4523.9 4615.3 4622.3 4650.1 369.6 4398.5 4407.1 4494.9 4545.7 4425.3 4430.9 4442.0 4464.2 4507.8 4420.4 4453.1 4470.4 4487.9 4507.7 4375.8 4450.0 4453.0 4499.2 4506.8 4852.8 4914.7 4933.7 4958.5 5005.3 5274.4 5327.8 5345.2 5354.6 5396.3 5329.4 5377.1 5380.6 5390.6 5437.6 4987.9 4988.8 4990.5 5015.4 5039.4 5220.6 5327.9 5342.7 5345.7 5360.4 5176.4 5186.9 5193.2 5201.9 5244.8 5275.2 5284.8 5288.5 5295.8 5344.5 5054.1 5183.7 5212.2 5229.6 5240.1 5220.9 5231.5 5252.9 5253.2 5272.8 4425.1 4425.7 4426.8 4456.9 4470.8 3779.6 3779.7 3817.7 3850.2 3856.7 4407.9 4424.8 4437.9 4468.4 4495.8 5255.0 5276.1 5278.3 5286.2 5324.8 4405.1 4499.0 4510.0 4546.6 4567.6 4792.2 4792.9 4805.5 4808.0 4858.6 4895.4 4969.2 4987.8 4988.2 5030.9 5066.0 5221.0 5234.8 5248.4 5256.1 4879.9 4880.7 4902.1 4919.0 4944.5 5090.1 5193.7 5193.9 5205.4 5217.4 5249.6 5259.9 5295.7 5306.7 5333.6 5164.8 5168.0 5181.1 5184.5 5211.5 4931.8 4966.7 5160.2 5172.9 5178.3 4981.6 4992.9 4995.7 5002.0 5071.1 5175.0 5180.7 5182.3 5190.7 5223.2 4885.6 4983.2 5063.3 5066.2 5068.2 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#1] ext.html Cycles:180 Average:45716.16 Median:36451.54 stddev:83569.99 (229.3%) stddev-sans-first:83735.58 01:18:29 INFO - PROCESS | 3457 | Values: 536.7 578.7 588.5 599.8 607.6 34182.0 34726.8 34782.3 34862.5 34959.7 38708.6 39085.8 39208.8 39419.6 39474.8 7689.8 7819.8 7826.3 7836.0 7862.3 7799.8 7859.6 7891.8 7905.4 7910.6 7838.6 7919.6 7939.9 7947.0 7955.3 7847.6 7858.1 7874.1 7875.5 7914.3 7849.3 7852.6 7900.1 7902.7 7917.3 38584.8 38604.0 38883.4 38888.8 39004.8 3145.5 3259.1 3357.6 3539.3 3785.7 29319.9 29698.0 29773.0 29828.1 31022.0 3342.9 3357.6 3369.3 3383.1 3454.4 243576.0 243934.0 244294.0 244569.0 245769.0 28890.7 29862.7 29864.0 54314.7 54997.7 32842.7 33013.5 33031.3 33047.2 33074.5 13120.7 13249.1 13308.5 13357.0 13388.1 11714.3 11763.5 11785.4 11806.9 11857.2 7878.1 7913.8 8000.0 8000.6 8038.8 3083.8 3178.2 3207.6 3220.0 3227.7 856.1 859.4 866.8 933.0 936.8 28137.4 28546.9 28801.6 29205.1 29572.0 844.4 870.2 909.8 935.7 1024.8 14646.0 14761.2 14813.0 15112.6 15282.8 373199.0 375462.0 377328.0 377866.0 380091.0 51098.2 51667.2 51670.0 51711.7 52022.5 1156.8 1179.9 1197.8 1197.9 1201.9 26828.7 28031.6 28162.9 28509.9 28580.1 43350.8 43582.3 43815.0 43879.0 43976.3 314749.0 315766.0 316167.0 316853.0 317350.0 25773.2 25992.6 26189.5 26804.1 26818.2 43035.6 43343.8 43730.8 43980.3 44335.3 37099.4 37398.1 37460.3 37517.0 38133.8 34583.3 36509.8 36711.6 37055.8 37286.6 36288.8 36393.3 36767.6 37117.8 37121.2 32516.3 33581.7 33646.5 34053.8 34062.3 25648.2 25693.4 25874.4 25885.4 26033.9 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#2] jquery.html Cycles:180 Average:23762.52 Median:5313.38 stddev:62204.61 (1170.7%) stddev-sans-first:62354.31 01:18:29 INFO - PROCESS | 3457 | Values: 366.7 369.9 376.1 379.3 389.9 15884.1 16363.6 16957.5 16964.2 16991.2 15895.9 16534.0 16819.3 16847.6 16871.7 5103.2 5265.5 5309.0 5313.3 5313.5 3775.7 5225.2 5776.4 6138.1 6144.7 6166.4 6173.5 6184.3 6185.3 6216.3 5068.0 5379.5 5392.5 5461.9 5477.3 5230.9 5270.1 5297.8 5360.3 5376.2 11640.1 11845.5 11897.4 19660.6 19941.7 1854.0 2082.8 2120.6 2125.1 2371.5 8698.0 9203.5 9251.2 9435.0 9586.4 1721.1 1779.3 1845.8 1855.8 1871.7 59853.7 60658.7 67134.0 67946.7 71312.3 9830.4 10192.5 10313.9 10406.9 10497.7 13681.7 13981.9 14012.6 14064.0 14080.8 7276.0 7743.2 7857.6 7884.6 7958.4 7632.4 7733.8 7764.7 7783.8 7786.8 4272.3 4349.4 4363.3 4519.1 4529.2 1676.9 1705.0 1724.4 1831.0 1894.3 831.3 882.7 941.1 965.0 980.7 16098.8 16814.7 16917.5 16982.1 17309.8 826.3 873.7 874.9 883.4 889.8 9122.3 9252.4 9714.5 10075.2 10182.0 369829.0 375258.0 377118.0 377395.0 379941.0 68291.0 72518.6 74731.0 82898.0 86456.0 893.2 910.3 917.3 935.5 941.7 16270.8 16342.8 16382.9 16433.4 16508.8 38211.0 38313.6 38591.6 39163.4 41049.6 53615.0 55049.4 55281.4 55661.0 56133.2 7591.5 7778.7 7845.3 7917.1 7924.4 8293.1 8306.1 8501.4 8520.3 8623.2 7385.6 7584.2 7718.9 7768.0 8029.7 7759.5 7889.7 7899.2 7930.9 8048.8 7339.4 7672.3 7735.7 7808.3 8091.0 11257.2 11635.1 11784.6 11788.5 12039.1 10506.6 10901.3 10965.5 11015.0 11280.8 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#3] mootools.html Cycles:180 Average:5217.64 Median:5691.37 stddev:2906.38 (51.1%) stddev-sans-first:2900.18 01:18:29 INFO - PROCESS | 3457 | Values: 1373.5 1410.9 1482.2 1651.8 1657.2 6857.7 7598.0 7604.8 8152.9 8154.2 7655.5 7884.6 7928.8 7985.3 7991.6 2176.5 2222.1 2222.8 2223.2 2232.0 2170.8 2201.9 2234.1 2237.6 2237.8 2211.7 2216.3 2222.3 2228.5 2234.4 2150.9 2156.5 2158.1 2168.6 2170.2 2179.9 2207.9 2210.8 2222.4 2224.7 7909.4 7952.1 7986.2 7987.8 8014.4 4507.3 4617.6 4627.2 4648.9 4650.6 2872.1 2947.3 2947.6 3017.8 3020.3 934.8 965.9 980.3 983.4 988.5 10746.6 10922.2 10934.9 10955.9 10957.7 4136.9 4168.1 4280.1 4283.6 4333.5 9317.8 9346.6 9369.5 9375.1 9381.0 4609.4 4646.4 4666.9 4680.3 4700.9 3793.7 4158.7 4174.8 4315.9 4324.8 3689.6 3760.8 3798.7 3815.3 3899.4 1183.7 1189.4 1200.0 1204.5 1212.7 802.4 810.8 839.7 843.8 852.5 5272.4 5685.7 5697.1 5718.1 5804.3 843.7 859.2 867.4 911.5 916.3 3789.2 3812.2 3894.4 3913.8 3916.6 9264.0 9538.3 9637.2 9645.9 9657.6 9427.0 9465.9 9472.4 9481.6 9521.0 7432.6 7441.8 7455.4 7555.1 7571.5 5598.8 5601.9 5602.6 5677.9 5812.4 9050.0 9074.0 9092.2 9192.5 9271.6 8864.0 9156.7 9166.3 9197.3 9224.2 5898.1 6350.0 6519.3 6626.8 6629.3 7586.1 7621.2 7647.2 7660.0 7675.2 6681.5 6902.5 6920.3 7038.3 7057.7 6783.8 6786.8 6901.1 7012.6 7024.2 6371.5 6392.0 6425.5 6430.1 6503.1 4243.7 4259.5 4320.2 4341.3 4349.8 4622.9 4670.7 4700.0 4705.8 4711.3 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#4] prototype.html Cycles:180 Average:4413.66 Median:5042.91 stddev:1275.72 (25.3%) stddev-sans-first:1241.38 01:18:29 INFO - PROCESS | 3457 | Values: 300.5 306.8 307.4 311.7 313.7 5032.9 5040.4 5045.4 5077.5 5113.2 4952.6 4972.8 4976.8 4996.7 5046.2 3714.3 3812.5 3935.8 3944.5 3969.6 3958.3 3969.6 3972.6 3978.3 3983.3 3952.3 3965.7 3982.2 3988.3 3990.3 3822.1 3928.0 3928.2 3961.8 3985.3 3490.4 3515.7 3523.5 3536.3 3537.0 4879.3 4930.9 4937.9 4955.1 4962.3 4401.1 4546.0 4558.6 4563.1 4564.1 5250.6 5256.6 5269.8 5272.2 5278.6 3841.2 3859.7 3866.1 3872.9 3879.9 5354.4 5542.6 5570.4 5570.5 5575.7 3880.8 3882.6 3883.0 3888.2 3897.8 3928.9 3956.8 3972.7 3973.6 3977.4 4495.3 4501.7 4506.7 4509.6 4535.6 5184.0 5314.1 5329.1 5330.3 5345.2 1392.0 1401.9 1407.3 1408.7 1409.4 860.9 886.3 893.4 906.0 912.3 4519.4 4647.4 4652.5 4657.7 4672.7 5400.1 5421.8 5429.2 5474.7 5500.0 4453.1 4630.2 4641.1 4641.1 4647.9 2880.7 2923.6 2926.8 2928.3 2928.4 5055.4 5085.3 5125.5 5134.2 5139.4 5433.6 5493.2 5516.8 5634.4 5662.6 5123.3 5133.7 5135.3 5160.8 5176.0 5422.9 5428.8 5482.4 5490.8 5561.1 5165.2 5396.2 5400.6 5470.6 5480.6 5107.5 5136.6 5166.7 5189.1 5215.3 3839.8 3853.9 3867.6 3883.5 3886.9 5172.9 5463.5 5483.2 5512.2 5515.1 5303.3 5303.8 5346.7 5374.5 5397.2 5149.8 5312.4 5363.4 5368.2 5399.6 5225.4 5244.2 5245.8 5256.6 5257.9 5195.2 5226.0 5369.4 5403.6 5419.1 5168.2 5233.6 5262.3 5264.0 5318.3 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - PROCESS | 3457 | [#5] yui.html Cycles:180 Average:15595.62 Median:44559.16 stddev:20594.55 (46.2%) stddev-sans-first:20621.88 01:18:29 INFO - PROCESS | 3457 | Values: 683.8 722.6 725.6 731.2 740.2 11594.9 12360.7 12473.4 12762.4 13254.3 13698.8 13701.4 13719.5 13789.4 13886.3 626.5 784.4 797.3 807.0 807.6 807.5 809.9 812.2 814.3 816.0 846.7 848.5 848.6 849.2 850.4 832.1 833.0 833.9 836.6 836.7 610.4 613.8 615.5 615.8 616.2 12576.7 12662.8 12667.4 12689.4 12693.0 14083.2 14254.0 14343.9 14511.3 14517.3 10632.4 10862.0 10885.3 10939.3 10977.5 3250.4 3376.9 3397.5 3424.8 3524.4 61384.0 61759.0 61826.0 61940.0 62623.7 10603.7 10638.8 10641.0 10702.7 10757.2 19858.5 19861.3 19861.4 19934.6 20100.4 6543.8 6553.9 6662.2 6669.9 6740.3 3561.3 3565.6 3583.9 3622.9 3647.9 2745.6 2833.6 2838.5 2846.7 2858.8 535.2 542.3 542.7 547.8 555.4 497.3 509.8 525.0 528.3 563.6 8021.4 8085.4 8098.4 8179.8 8237.4 556.5 568.2 580.8 586.0 587.6 3678.2 3749.7 3781.3 3887.5 3913.4 54130.0 54439.0 54637.7 96507.5 97527.5 47623.3 48062.3 48818.0 55503.7 78720.0 43585.0 45122.1 46764.5 52574.0 73288.6 7071.6 7175.3 7210.2 7217.3 7294.7 44109.0 45009.3 45447.5 45803.8 46092.8 61955.0 63861.0 64269.0 64301.0 64431.7 10140.9 10156.3 10228.3 10466.9 10561.5 10772.1 10864.4 10932.4 11304.1 11343.2 9952.3 10036.9 10118.0 10190.1 10228.1 10321.7 10341.6 10448.5 10495.5 10907.1 10333.8 10351.7 11688.7 11897.5 12717.7 10199.3 10313.6 10442.6 10522.9 11235.1 10350.6 10551.5 10609.5 10741.4 10782.8 01:18:29 INFO - PROCESS | 3457 | -------- Summary: end -------- 01:18:29 INFO - PROCESS | 3457 | 01:18:29 INFO - TEST-INFO | 3457: exit 0 01:18:29 INFO - TEST-OK | dromaeo_css | took 1118605ms 01:18:29 INFO - TEST-START | kraken 01:18:29 INFO - operating with platform_type : linux_ 01:18:29 INFO - Initialising browser for kraken test... 01:18:29 INFO - TEST-INFO | started process 3695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKQx67/profile http://localhost:38651/getInfo.html) 01:18:35 INFO - PROCESS | 3695 | __metrics Screen width/height:1600/1200 01:18:35 INFO - PROCESS | 3695 | colorDepth:24 01:18:35 INFO - PROCESS | 3695 | Browser inner width/height: 1024/697 01:18:35 INFO - PROCESS | 3695 | __metrics 01:18:35 ERROR - PROCESS | 3695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:18:36 INFO - TEST-INFO | 3695: exit 0 01:18:36 INFO - Browser initialized. 01:18:36 INFO - Running cycle 1/1 for kraken test... 01:18:36 INFO - TEST-INFO | started process 3812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKQx67/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:18:49 INFO - PROCESS | 3812 | RSS: Main: 186834944 01:18:49 INFO - PROCESS | 3812 | 01:18:51 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38651/tests/kraken/driver.html?testName=audio-beat-detection) 01:18:52 INFO - PROCESS | 3812 | RSS: Main: 190894080 01:18:52 INFO - PROCESS | 3812 | 01:18:55 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38651/tests/kraken/driver.html?testName=audio-dft) 01:18:56 INFO - PROCESS | 3812 | RSS: Main: 190701568 01:18:56 INFO - PROCESS | 3812 | 01:18:59 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38651/tests/kraken/driver.html?testName=audio-fft) 01:18:59 INFO - PROCESS | 3812 | RSS: Main: 186814464 01:18:59 INFO - PROCESS | 3812 | 01:19:01 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38651/tests/kraken/driver.html?testName=audio-oscillator) 01:19:02 INFO - PROCESS | 3812 | RSS: Main: 187449344 01:19:02 INFO - PROCESS | 3812 | 01:19:04 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:05 INFO - PROCESS | 3812 | RSS: Main: 187875328 01:19:05 INFO - PROCESS | 3812 | 01:19:08 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38651/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:09 INFO - PROCESS | 3812 | RSS: Main: 188215296 01:19:09 INFO - PROCESS | 3812 | 01:19:12 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38651/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:13 INFO - PROCESS | 3812 | RSS: Main: 185135104 01:19:13 INFO - PROCESS | 3812 | 01:19:16 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38651/tests/kraken/driver.html?testName=json-parse-financial) 01:19:16 INFO - PROCESS | 3812 | RSS: Main: 186511360 01:19:16 INFO - PROCESS | 3812 | 01:19:18 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:19 INFO - PROCESS | 3812 | RSS: Main: 187084800 01:19:19 INFO - PROCESS | 3812 | 01:19:21 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:21 INFO - PROCESS | 3812 | RSS: Main: 187498496 01:19:21 INFO - PROCESS | 3812 | 01:19:23 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:19:24 INFO - PROCESS | 3812 | RSS: Main: 187330560 01:19:24 INFO - PROCESS | 3812 | 01:19:27 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:19:28 INFO - PROCESS | 3812 | RSS: Main: 187645952 01:19:28 INFO - PROCESS | 3812 | 01:19:31 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:19:31 INFO - PROCESS | 3812 | RSS: Main: 187539456 01:19:31 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:38651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38651/tests/kraken/driver.html?testName=ai-astar) 01:19:33 INFO - PROCESS | 3812 | RSS: Main: 188129280 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | __start_tp_report 01:19:33 INFO - PROCESS | 3812 | _x_x_mozilla_page_load 01:19:33 INFO - PROCESS | 3812 | _x_x_mozilla_page_load_details 01:19:33 INFO - PROCESS | 3812 | |i|pagename|runs| 01:19:33 INFO - PROCESS | 3812 | |0;ai-astar;116;109;112;114;112;113;112;111;114;113 01:19:33 INFO - PROCESS | 3812 | |1;audio-beat-detection;159;131;153;185;132;160;162;139;189;130 01:19:33 INFO - PROCESS | 3812 | |2;audio-dft;165;166;173;167;165;166;167;162;161;162 01:19:33 INFO - PROCESS | 3812 | |3;audio-fft;75;75;76;155;80;76;76;74;164;77 01:19:33 INFO - PROCESS | 3812 | |4;audio-oscillator;88;86;161;88;88;88;137;85;86;131 01:19:33 INFO - PROCESS | 3812 | |5;imaging-gaussian-blur;118;118;119;118;118;117;118;120;119;118 01:19:33 INFO - PROCESS | 3812 | |6;imaging-darkroom;150;148;147;147;149;147;147;148;149;148 01:19:33 INFO - PROCESS | 3812 | |7;imaging-desaturate;95;95;96;97;96;96;96;96;95;96 01:19:33 INFO - PROCESS | 3812 | |8;json-parse-financial;64;63;66;65;68;64;64;64;64;63 01:19:33 INFO - PROCESS | 3812 | |9;json-stringify-tinderbox;66;65;66;66;65;65;66;66;66;65 01:19:33 INFO - PROCESS | 3812 | |10;stanford-crypto-aes;87;83;88;83;87;85;86;85;117;85 01:19:33 INFO - PROCESS | 3812 | |11;stanford-crypto-ccm;140;144;135;142;153;142;144;144;145;142 01:19:33 INFO - PROCESS | 3812 | |12;stanford-crypto-pbkdf2;176;175;170;171;174;173;177;170;171;179 01:19:33 INFO - PROCESS | 3812 | |13;stanford-crypto-sha256-iterative;69;69;69;67;71;72;67;70;66;66 01:19:33 INFO - PROCESS | 3812 | __end_tp_report 01:19:33 INFO - PROCESS | 3812 | __start_cc_report 01:19:33 INFO - PROCESS | 3812 | _x_x_mozilla_cycle_collect,986 01:19:33 INFO - PROCESS | 3812 | __end_cc_report 01:19:33 INFO - PROCESS | 3812 | __startTimestamp1466583573980__endTimestamp 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | ------- Summary: start ------- 01:19:33 INFO - PROCESS | 3812 | Number of tests: 14 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.90 (1.7%) stddev-sans-first:1.56 01:19:33 INFO - PROCESS | 3812 | Values: 116.0 109.0 112.0 114.0 112.0 113.0 112.0 111.0 114.0 113.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:159.50 stddev:21.41 (13.4%) stddev-sans-first:22.63 01:19:33 INFO - PROCESS | 3812 | Values: 159.0 131.0 153.0 185.0 132.0 160.0 162.0 139.0 189.0 130.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:3.44 (2.1%) stddev-sans-first:3.64 01:19:33 INFO - PROCESS | 3812 | Values: 165.0 166.0 173.0 167.0 165.0 166.0 167.0 162.0 161.0 162.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.25 (46.4%) stddev-sans-first:36.80 01:19:33 INFO - PROCESS | 3812 | Values: 75.0 75.0 76.0 155.0 80.0 76.0 76.0 74.0 164.0 77.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:87.00 stddev:28.09 (32.3%) stddev-sans-first:29.20 01:19:33 INFO - PROCESS | 3812 | Values: 88.0 86.0 161.0 88.0 88.0 88.0 137.0 85.0 86.0 131.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 01:19:33 INFO - PROCESS | 3812 | Values: 118.0 118.0 119.0 118.0 118.0 117.0 118.0 120.0 119.0 118.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:0.83 01:19:33 INFO - PROCESS | 3812 | Values: 150.0 148.0 147.0 147.0 149.0 147.0 147.0 148.0 149.0 148.0 01:19:33 INFO - PROCESS | 3812 | 01:19:33 INFO - PROCESS | 3812 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 01:19:33 INFO - PROCESS | 3812 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 01:19:34 INFO - PROCESS | 3812 | Values: 64.0 63.0 66.0 65.0 68.0 64.0 64.0 64.0 64.0 63.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:19:34 INFO - PROCESS | 3812 | Values: 66.0 65.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.50 stddev:10.11 (11.8%) stddev-sans-first:10.71 01:19:34 INFO - PROCESS | 3812 | Values: 87.0 83.0 88.0 83.0 87.0 85.0 86.0 85.0 117.0 85.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:144.00 stddev:4.51 (3.1%) stddev-sans-first:4.64 01:19:34 INFO - PROCESS | 3812 | Values: 140.0 144.0 135.0 142.0 153.0 142.0 144.0 144.0 145.0 142.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.50 stddev:3.13 (1.8%) stddev-sans-first:3.20 01:19:34 INFO - PROCESS | 3812 | Values: 176.0 175.0 170.0 171.0 174.0 173.0 177.0 170.0 171.0 179.0 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - PROCESS | 3812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 01:19:34 INFO - PROCESS | 3812 | Values: 69.0 69.0 69.0 67.0 71.0 72.0 67.0 70.0 66.0 66.0 01:19:34 INFO - PROCESS | 3812 | -------- Summary: end -------- 01:19:34 INFO - PROCESS | 3812 | 01:19:34 INFO - TEST-INFO | 3812: exit 0 01:19:35 INFO - TEST-OK | kraken | took 65057ms 01:19:35 INFO - SUITE-END | took 1183s 01:19:35 INFO - Completed test suite (00:19:43) 01:19:35 INFO - javascript benchmark 01:19:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6395.180058757663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.1809239135864, 2691.6231727558134, 2694.030149146307, 2701.797365197608, 2711.1730922068773, 4784.40194975628, 4801.687890287133, 4829.613630909527, 4886.975565122169, 4946.431160416553, 4801.087793319267, 4883.975580122104, 4914.410270767504, 4946.530079642428, 4956.083124621948, 4474.753888536129, 4523.8642840714665, 4615.26155815068, 4622.329762184481, 4650.116477869211, 369.60142364992805, 4398.494173170095, 4407.118576284756, 4494.865154045384, 4545.659075569329, 4425.314076318144, 4430.867073987785, 4441.955580444186, 4464.218761716719, 4507.842225522124, 4420.40324556184, 4453.064856380164, 4470.351798989161, 4487.865364039084, 4507.729536227836, 4375.781210939472, 4450.020995381011, 4453.0, 4499.235130027871, 4506.752128632924, 4852.830150944736, 4914.70511769295, 4933.654644174909, 4958.528939750718, 5005.27423523587, 5274.393444753864, 5327.813526526592, 5345.198220266952, 5354.598405119632, 5396.298481197458, 5329.360476742777, 5377.11277639189, 5380.5964552658315, 5390.6226564140525, 5437.646552974044, 4987.877727511281, 4988.825391111293, 4990.451050384455, 5015.423226329019, 5039.395272567315, 5220.582353411718, 5327.893442131136, 5342.732863356817, 5345.705986170798, 5360.410354860962, 5176.378834539879, 5186.92219616706, 5193.195054766517, 5201.895962080737, 5244.842654720364, 5275.182346736262, 5284.788608455696, 5288.471152884757, 5295.814646487354, 5344.518993290622, 5054.09026375256, 5183.688978661293, 5212.218167274939, 5229.555487783505, 5240.135377662719, 5220.869478262998, 5231.450697676689, 5252.947470525322, 5253.238280449314, 5272.762725677354, 4425.070735145591, 4425.668074894395, 4426.756528390905, 4456.866294011184, 4470.821167153277, 3779.640934111255, 3779.6787273082095, 3817.7136714746507, 3850.210706805098, 3856.7300288980064, 4407.933880991788, 4424.75663838492, 4437.866863994085, 4468.352088947085, 4495.842645507391, 5255.0, 5276.129438642658, 5278.340207474066, 5286.207068939613, 5324.8136315228785, 4405.074934263776, 4499.0, 4509.977450112729, 4546.590806827401, 4567.611753000966, 4792.161371759928, 4792.880177995578, 4805.495422980537, 4807.975960120247, 4858.6356023298395, 4895.363602731622, 4969.229769385751, 4987.80048798044, 4988.201887697878, 5030.949690503048, 5066.03745288394, 5221.0, 5234.842954711365, 5248.3701955765555, 5256.053910296183, 4879.902401952012, 4880.731559764105, 4902.117618828503, 4919.0, 4944.456109827845, 5090.0583392072585, 5193.662411943212, 5193.896122077462, 5205.427402985744, 5217.373915130209, 5249.580033597379, 5259.947400525945, 5295.735213239245, 5306.6550674206055, 5333.599980001438, 5164.845054648366, 5167.974160129175, 5181.093308670892, 5184.507471790174, 5211.5049070338255, 4931.753412329297, 4966.6771659842, 5160.225966104964, 5172.870678233075, 5178.300929374486, 4981.6014718823135, 4992.900141997213, 4995.725235112103, 5001.974990125026, 5071.0872043032605, 5175.0167468180925, 5180.6891586503425, 5182.300389447376, 5190.688558686491, 5223.21651752225, 4885.5847252983895, 4983.202687569971, 5063.26582645507, 5066.240063990431, 5068.163752980717], "value": 4786.410975543469, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.6866455125945, 578.7424596054755, 588.5115354255967, 599.7960693364255, 607.5504126946059, 34182.0, 34726.8263658682, 34782.30435391291, 34862.477062844046, 34959.65040349593, 38708.61291387085, 39085.8045709771, 39208.803955980184, 39419.60580394195, 39474.80262598683, 7689.846203075949, 7819.804504887366, 7826.334761545247, 7835.960820195891, 7862.292393684567, 7799.805004874866, 7859.607019649024, 7891.802704932394, 7905.367570594339, 7910.644021019068, 7838.568878711669, 7919.604019799016, 7939.880901786478, 7947.0, 7955.284024437799, 7847.6468558914985, 7858.135605083407, 7874.133845277015, 7875.527468351917, 7914.3272821810215, 7849.254320839568, 7852.607369631495, 7900.091489478668, 7902.723404680809, 7917.2874441300555, 38584.80707596444, 38604.0, 38883.416748748794, 38888.80555597232, 39004.804975975225, 3145.496720524728, 3259.103746469716, 3357.61387440445, 3539.327527769741, 3785.6971442284553, 29319.85340073286, 29698.0, 29773.0, 29828.10515684533, 31022.0, 3342.8829990950444, 3357.6474470180524, 3369.275605744777, 3383.069655844638, 3454.4300190468543, 243576.0, 243934.0, 244294.0, 244569.0, 245769.0, 28890.711092888803, 29862.701372986427, 29864.0, 54314.728426357615, 54997.725011374685, 32842.67157328396, 33013.50479742806, 33031.33937321288, 33047.17382065419, 33074.503882441786, 13120.671983200496, 13249.13880597758, 13308.467661293633, 13357.0, 13388.129771564818, 11714.297142171497, 11763.529458821722, 11785.410729463492, 11806.94096529529, 11857.229280096766, 7878.1334053254095, 7913.841723165505, 8000.0, 8000.5599692017495, 8038.758837234892, 3083.8149711016963, 3178.2372230664473, 3207.5830142081845, 3219.9839000805314, 3227.7095061444584, 856.118198255785, 859.3640705877606, 866.8309679612415, 932.958016889228, 936.8196072948134, 28137.43725125486, 28546.857265713956, 28801.567976480368, 29205.123846284645, 29572.0, 844.3751623798468, 870.2037635563389, 909.8043920557112, 935.6678379175431, 1024.7899180667946, 14646.048006879519, 14761.188134652482, 14813.0, 15112.622184445258, 15282.770758438632, 373199.0, 375462.0, 377328.0, 377866.0, 380091.0, 51098.23352649713, 51667.2249916244, 51670.0, 51711.74144129255, 52022.47977520252, 1156.7859945910034, 1179.9056075513938, 1197.8143387774908, 1197.886200810939, 1201.9038476921826, 26828.731712682624, 28031.579526306712, 28162.85918570394, 28509.857450712614, 28580.14259572216, 43350.78324608483, 43582.346264806685, 43815.0, 43879.0, 43976.34035489534, 314749.0, 315766.0, 316167.0, 316853.0, 317350.0, 25773.226803195936, 25992.610110847974, 26189.476210475303, 26804.06185783488, 26818.195454136407, 43035.569644303156, 43343.78328108339, 43730.78134609306, 43980.34029489496, 44335.334969976124, 37099.44350834793, 37398.06504837292, 37460.250794984495, 37517.0, 38133.809330954275, 34583.30833383369, 36509.817450912575, 36711.63288367082, 37055.814720926224, 37286.62713372832, 36288.81855590705, 36393.272134557694, 36767.63232367642, 37117.81441092777, 37121.21590880641, 32516.34967300688, 33581.664183357854, 33646.495302569994, 34053.82973085119, 34062.31875362429, 25648.23055308344, 25693.35766605775, 25874.44753314807, 25885.352866178495, 26033.869830650725], "value": 16478.203625701448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.7322854316349, 369.87054530914185, 376.0936143893217, 379.27369088196104, 389.92786334528097, 15884.126373049477, 16363.590910227236, 16957.49127526176, 16964.236609352578, 16991.150442477858, 15895.92052039741, 16534.0, 16819.32722691094, 16847.578810529743, 16871.746923796152, 5103.209002604603, 5265.526102650761, 5309.044372013036, 5313.256144139824, 5313.495217954288, 3775.697944164474, 5225.242339860718, 5776.422357764232, 6138.109974053759, 6144.678894037781, 6166.4450199482035, 6173.506119510451, 6184.25788905332, 6185.257769067695, 6216.316205217422, 5067.974660126694, 5379.542738867201, 5392.514673679388, 5461.863453413656, 5477.260569823063, 5230.8692282692855, 5270.130428479296, 5297.841064768063, 5360.3299587551555, 5376.193570964348, 11640.06879449642, 11845.466953987092, 11897.405129743565, 19660.606787864304, 19941.700874486894, 1853.9907300463547, 2082.7500699915954, 2120.5758848230416, 2125.0649714125734, 2371.5019845832394, 8697.95651021741, 9203.493807840567, 9251.213646840026, 9434.95282523583, 9586.424814511152, 1721.1394302848576, 1779.2616064333286, 1845.796962334142, 1855.7958624551425, 1871.7192421136801, 59853.7007314965, 60658.69670651619, 67134.0, 67946.66026669835, 71312.28687713109, 9830.4101753895, 10192.541335639915, 10313.9484302578, 10406.947965260126, 10497.737556561147, 13681.657958551115, 13981.930090349482, 14012.579622611338, 14064.0, 14080.788788168185, 7276.038161592953, 7743.225677432211, 7857.646405911748, 7884.605769711491, 7958.442908996315, 7632.3512501438, 7733.8453230935065, 7764.728234511765, 7783.766487005399, 7786.7663970080985, 4272.252355837716, 4349.391085248068, 4363.345498175299, 4519.0961807638605, 4529.230030894756, 1676.8574671152844, 1704.991475042617, 1724.3792234795465, 1830.9816901831077, 1894.327513732605, 831.3100126894662, 882.6601758322963, 941.1294552538874, 964.9517524123765, 980.6861804222723, 16098.75851862223, 16814.663706725798, 16917.49247522576, 16982.065986370868, 17309.826901731074, 826.2646244842095, 873.6592728835759, 874.8512752832033, 883.412530667112, 889.8131392407666, 9122.315826313054, 9252.398594091363, 9714.514274286257, 10075.193984481224, 10182.0, 369829.0, 375258.0, 377118.0, 377395.0, 379941.0, 68291.0, 72518.63740681263, 74731.0, 82898.0, 86456.0, 893.2318206342541, 910.3081657939881, 917.3303488453466, 935.504182783126, 941.7410212191702, 16270.755938661167, 16342.836571634132, 16382.918085409498, 16433.424830130887, 16508.83491165073, 38211.0, 38313.61686383212, 38591.6140838588, 39163.41254881122, 41049.589504105774, 53615.0, 55049.44950550603, 55281.447185529236, 55661.0, 56133.15800263081, 7591.544507329357, 7778.688852445839, 7845.293923546908, 7917.089534703583, 7924.366050715814, 8293.087760346236, 8306.086330503518, 8501.362397820065, 8520.318374530147, 8623.223909848144, 7385.5937923412575, 7584.241575842371, 7718.8544224057905, 7767.961160194162, 8029.7189598363775, 7759.495632783851, 7889.723859664884, 7899.210078992055, 7930.881036784568, 8048.774418315292, 7339.449541284532, 7672.271134242238, 7735.6905723770415, 7808.297253247235, 8091.029076510621, 11257.15571332137, 11635.127365447455, 11784.646460606196, 11788.528458861892, 12039.097067720131, 10506.579736810441, 10901.295703142352, 10965.451727413756, 11015.0, 11280.774384512428], "value": 8133.34475816191, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.5329987804143, 1410.8730214280715, 1482.1699848085073, 1651.8265582113886, 1657.1631326180277, 6857.691403886824, 7598.0, 7604.847903041936, 8152.91847081529, 8154.225348591882, 7655.540667559951, 7884.566348850811, 7928.841423171548, 7985.281324680777, 7991.600419978992, 2176.455886028493, 2222.122261706625, 2222.7777222277805, 2223.188536184289, 2232.006756993139, 2170.8046275835172, 2201.9210586812505, 2234.084025549525, 2237.6196046672026, 2237.7874101960288, 2211.7124773779465, 2216.293454040388, 2222.3221917315213, 2228.5097278598764, 2234.441389652587, 2150.903209355583, 2156.450105223166, 2158.136745301876, 2168.609650262952, 2170.197027099975, 2179.9128034878586, 2207.8564893282046, 2210.8341874359326, 2222.411061068818, 2224.655178447327, 7909.406794490436, 7952.125266220711, 7986.2013798620255, 7987.760367188994, 8014.358851291941, 4507.346434766941, 4617.607503362218, 4627.23650597651, 4648.883777905579, 4650.581447669726, 2872.1261711795046, 2947.263184203949, 2947.5873377727135, 3017.8038427502142, 3020.3053297741644, 934.7896723237217, 965.9275554333383, 980.3333733061515, 983.4148681534475, 988.5403287471361, 10746.570137194582, 10922.235443518957, 10934.890651093467, 10955.890441095567, 10957.671269861918, 4136.937945930814, 4168.083021735213, 4280.07978284664, 4283.571642835692, 4333.458317710286, 9317.813643727088, 9346.626134954662, 9369.531523423802, 9375.10936461035, 9380.95309523448, 4609.354690343354, 4646.442426908725, 4666.929996050062, 4680.297955306663, 4700.88247793801, 3793.7344385893275, 4158.6673066154635, 4174.812133454002, 4315.913681726348, 4324.762138082373, 3689.5572531296416, 3760.7931563764255, 3798.7150963677836, 3815.3323168445413, 3899.3566061599518, 1183.674489515373, 1189.4469071881617, 1199.9820002699967, 1204.5181927229178, 1212.7331986962854, 802.4222559756965, 810.8041379650913, 839.7010664203427, 843.843888880559, 852.5311078906576, 5272.393674727378, 5685.687287199244, 5697.059985102412, 5718.1136923776885, 5804.2744656917885, 843.7131375332416, 859.2352806002663, 867.4101610904519, 911.4850109688005, 916.2715641065369, 3789.223209242154, 3812.1803812180515, 3894.4353068804867, 3913.8043097844993, 3916.5691773904846, 9263.95368023169, 9538.3323167379, 9637.18083962857, 9645.855312170323, 9657.565409556586, 9426.95286523563, 9465.90534094664, 9472.431654100637, 9481.573329200202, 9521.0, 7432.62836858155, 7441.813954651068, 7455.4035677146785, 7555.13115991668, 7571.46999710015, 5598.776048958159, 5601.887962240651, 5602.5517958562405, 5677.858053548694, 5812.360640329476, 9050.0, 9074.0, 9092.181703646704, 9192.540372981457, 9271.582778774837, 8864.0, 9156.725298241063, 9166.266698664223, 9197.31020173503, 9224.169824715807, 5898.115282707457, 6350.015747559136, 6519.250286217146, 6626.768063117768, 6629.303923088007, 7586.089669239726, 7621.1997740236475, 7647.235276472308, 7659.961700191463, 7675.155732869268, 6681.498887583353, 6902.482313826383, 6920.273371296143, 7038.260982596754, 7057.682404291922, 6783.762568310085, 6786.830329241809, 6901.102856628606, 7012.614306213003, 7024.1571011478945, 6371.458426033839, 6392.0411938209645, 6425.518086143651, 6430.067640192053, 6503.122078519339, 4243.724157929724, 4259.531451540266, 4320.179165958458, 4341.283688191413, 4349.782510874507, 4622.86131416058, 4670.673052886265, 4699.953000469952, 4705.8352957647685, 4711.269753188124], "value": 4209.228485103374, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.51916932907346, 306.8281762213161, 307.3576225688312, 311.6696301919965, 313.7270574600098, 5032.924506132402, 5040.445550989393, 5045.369328833895, 5077.466865979074, 5113.156329205676, 4952.603791696655, 4972.751362431882, 4976.755811047238, 4996.67521611095, 5046.192609182532, 3714.349988751971, 3812.5043744313202, 3935.7835319057585, 3944.467496887912, 3969.563348031714, 3958.2677204717074, 3969.6030396960364, 3972.5500192429845, 3978.3037968355566, 3983.302921988655, 3952.2688302663955, 3965.662918651918, 3982.203559288154, 3988.34192358262, 3990.2817492851277, 3822.140018495844, 3928.0, 3928.1750832325247, 3961.8019099045077, 3985.3424185009585, 3490.3542844573835, 3515.6660117288816, 3523.5243242162237, 3536.257385948954, 3536.974277459534, 4879.316895634614, 4930.876728081791, 4937.938343256181, 4955.126026904423, 4962.280469331963, 4401.106734289412, 4546.0, 4558.566936141061, 4563.06457176278, 4564.109998550251, 5250.553702935255, 5256.553192978601, 5269.789208431658, 5272.182811664198, 5278.630495865291, 3841.2355891226753, 3859.6912247020173, 3866.0528170598104, 3872.9031774205587, 3879.9030024249337, 5354.43778403266, 5542.558934676973, 5570.387257401682, 5570.498655121059, 5575.665460072409, 3880.825362858678, 3882.5729169791302, 3883.0, 3888.2223555289056, 3897.824597893102, 3928.9214215716097, 3956.841726330972, 3972.741771784825, 3973.562908080109, 3977.423273625308, 4495.325701144854, 4501.6848820582245, 4506.684532082788, 4509.6392288616835, 4535.614472769786, 5184.0, 5314.070037743457, 5329.108166600801, 5330.307060082242, 5345.171498417673, 1391.9652008699863, 1401.8878489721, 1407.331517529186, 1408.7464256433736, 1409.443269908401, 860.9182127697984, 886.3308202307217, 893.3657103456488, 905.9773505662412, 912.2519533982204, 4519.367288579601, 4647.442306923191, 4652.534746525388, 4657.650676199299, 4672.719636821802, 5400.108982017923, 5421.810236641778, 5429.239906413105, 5474.671519708831, 5500.009998200282, 4453.105481437092, 4630.166570017429, 4641.052931388593, 4641.118187544424, 4647.930281045787, 2880.683124856264, 2923.5906973023793, 2926.824390536575, 2928.3264849084403, 2928.3996780659913, 5055.368078990126, 5085.262636917626, 5125.4874512549195, 5134.178531434953, 5139.357580302462, 5433.592480563894, 5493.176023596492, 5516.834494965157, 5634.3802181759975, 5662.556048207681, 5123.257127716461, 5133.666311689728, 5135.255387968724, 5160.845174644692, 5175.990681817085, 5422.891542169214, 5428.809991650273, 5482.39693633692, 5490.835274941758, 5561.138023606348, 5165.225216217447, 5396.163594642837, 5400.594955378441, 5470.562355011669, 5480.588955828249, 5107.514786095315, 5136.563392111563, 5166.689998600096, 5189.054104710734, 5215.348081489814, 3839.827207775601, 3853.8651147210835, 3867.563435035909, 3883.5339759229073, 3886.8833934981994, 5172.922406163986, 5463.453654634504, 5483.150111732688, 5512.173174023928, 5515.145152501369, 5303.329451222852, 5303.840884773463, 5346.652467589594, 5374.4625537445945, 5397.217403476396, 5149.775535338304, 5312.362516498045, 5363.383210930793, 5368.1679339702405, 5399.622026458111, 5225.372955245395, 5244.213367994831, 5245.790168393374, 5256.554447526961, 5257.8695580450385, 5195.168772996302, 5225.973870130625, 5369.4093649697725, 5403.621746477709, 5419.132938729785, 5168.198929165986, 5233.555147812479, 5262.26328314044, 5263.973680131575, 5318.255444237887], "value": 4006.710381149371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.781190019194, 722.6350692900081, 725.5682868693127, 731.2102928836857, 740.2264633458036, 11594.884051159486, 12360.690982725437, 12473.37633118344, 12762.36188190589, 13254.271015094166, 13698.794518082237, 13701.3834377453, 13719.451221951134, 13789.448422063131, 13886.305684715775, 626.4675026227716, 784.4391260248921, 797.3063434811708, 806.9993208421545, 807.5881300536739, 807.4711064252895, 809.8987626546682, 812.1675282835112, 814.250889181954, 816.0411516468156, 846.6571038729294, 848.499385362636, 848.5629900601195, 849.218718778722, 850.3919697416346, 832.063928080909, 833.0, 833.8874251975997, 836.5984327522823, 836.6527890925258, 610.3896103896104, 613.8281281241215, 615.4799194680488, 615.8152554233712, 616.1866336435907, 12576.68558286041, 12662.81005784914, 12667.429965651569, 12689.36553172347, 12693.0, 14083.155010699391, 14254.0, 14343.85656143446, 14511.274436278143, 14517.274136293143, 10632.415217163052, 10862.02241798242, 10885.292455990415, 10939.343639381663, 10977.506012229469, 3250.3509639643617, 3376.9493457598155, 3397.541331920184, 3424.8116353600544, 3524.4184709522897, 61384.0, 61759.0, 61826.0, 61940.0, 62623.6868815653, 10603.681889543326, 10638.840417393745, 10641.0, 10702.73243168927, 10757.246992710436, 19858.50353741139, 19861.30485433003, 19861.404157875288, 19934.60130797376, 20100.396988090382, 6543.770968016097, 6553.91860343038, 6662.200535935719, 6669.933300666931, 6740.325967403319, 3561.30554541867, 3565.5721313442555, 3583.8924832255075, 3622.873199438007, 3647.908802279911, 2745.6156138140677, 2833.617461642652, 2838.460692468466, 2846.658400991853, 2858.757005654501, 535.1571275241432, 542.3085565903505, 542.6608369768894, 547.8329109621524, 555.4473299067373, 497.29632569913167, 509.77315094783205, 524.9763760630781, 528.3395755305868, 563.6449037106596, 8021.398395120389, 8085.3531717462465, 8098.392620553482, 8179.754607361789, 8237.423380363436, 556.4908109080146, 568.2130249604328, 580.7996241296746, 585.9560532960045, 587.5974957154363, 3678.1540245743627, 3749.718771092179, 3781.3193625147737, 3887.5140607424073, 3913.373860182357, 54130.0, 54439.0, 54637.72681136569, 96507.51746241364, 97527.51236243773, 47623.28565071527, 48062.279065814044, 48818.0, 55503.72248138733, 78720.0, 43585.0, 45122.09755804931, 46764.532354676696, 52574.0, 73288.63355683294, 7071.611061391673, 7175.282471752783, 7210.206877243394, 7217.33746130031, 7294.671739771829, 44109.0, 45009.32486012647, 45447.545524545654, 45803.77098114488, 46092.769536152104, 61955.0, 63861.0, 64269.0, 64301.03548446683, 64431.67784161049, 10140.898591014291, 10156.26165250553, 10228.335158214692, 10466.895331046897, 10561.524731386953, 10772.138228941823, 10864.402457864893, 10932.363954627646, 11304.095672346357, 11343.20597558163, 9952.303338766216, 10036.899631003596, 10118.0, 10190.082892539707, 10228.079472847181, 10321.690349289533, 10341.586336546454, 10448.52981615814, 10495.52770125331, 10907.127429805438, 10333.793324133625, 10351.68944931623, 11688.70778230551, 11897.524099035942, 12717.682057948625, 10199.28604997643, 10313.587456501657, 10442.582296708046, 10522.894771052192, 11235.073607904536, 10350.585976560853, 10551.525181366704, 10609.522571484147, 10741.355518668905, 10782.838257425989], "value": 6322.573709569552, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.6999999999994, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 112.0, 114.0, 112.0, 113.0, 112.0, 111.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 153.0, 185.0, 132.0, 160.0, 162.0, 139.0, 189.0, 130.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 173.0, 167.0, 165.0, 166.0, 167.0, 162.0, 161.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 155.0, 80.0, 76.0, 76.0, 74.0, 164.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 161.0, 88.0, 88.0, 88.0, 137.0, 85.0, 86.0, 131.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 117.0, 118.0, 120.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 148.0, 149.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 65.0, 68.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 88.0, 83.0, 87.0, 85.0, 86.0, 85.0, 117.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 135.0, 142.0, 153.0, 142.0, 144.0, 144.0, 145.0, 142.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 170.0, 171.0, 174.0, 173.0, 177.0, 170.0, 171.0, 179.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 67.0, 71.0, 72.0, 67.0, 70.0, 66.0, 66.0], "value": 68.6, "unit": "score"}]}]} 01:19:35 INFO - Return code: 0 01:19:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:19:35 ERROR - # TBPL SUCCESS # 01:19:35 INFO - Running post-action listener: _resource_record_post_action 01:19:35 INFO - ##### 01:19:35 INFO - ##### Finished run-tests step (success) 01:19:35 INFO - ##### 01:19:35 INFO - Running post-run listener: _resource_record_post_run 01:19:35 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7819264; Write bytes: 492445696; Read time: 1872; Write time: 455332 01:19:35 INFO - TinderboxPrint: CPU usage
13.4% 01:19:35 INFO - TinderboxPrint: I/O read bytes / time
7,819,264 / 1,872 01:19:35 INFO - TinderboxPrint: I/O write bytes / time
492,445,696 / 455,332 01:19:35 INFO - TinderboxPrint: CPU idle
8,292.8 (86.5%) 01:19:35 INFO - TinderboxPrint: CPU user
1,229.2 (12.8%) 01:19:35 INFO - TinderboxPrint: Swap in / out
0 / 0 01:19:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76627968; Read time: 0; Write time: 80080 01:19:35 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6057984; Write bytes: 415817728; Read time: 1808; Write time: 375252 01:19:35 INFO - Running post-run listener: _upload_blobber_files 01:19:35 INFO - Blob upload gear active. 01:19:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:19:35 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 01:19:35 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'] 01:19:35 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 01:19:36 INFO - (blobuploader) - INFO - Open directory for files ... 01:19:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:19:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:37 INFO - (blobuploader) - INFO - Done attempting. 01:19:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:19:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:40 INFO - (blobuploader) - INFO - Done attempting. 01:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:41 INFO - (blobuploader) - INFO - Done attempting. 01:19:41 INFO - (blobuploader) - INFO - Iteration through files over. 01:19:41 INFO - Return code: 0 01:19:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:19:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:19:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec8215dd0356f6165c2509b09150e7db206a1a3bc0e527069359c462399038b7000266072de42fe9f5734d16d219e371247cde21da33e16509e597a8495e1651", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b61e163a923d994f7c434539478fadebb70bc5e9d7256b79c16f1a867aaaf3138eaa471a2ce07c0e84f5b7fa042ddc5313193c7cd84e42d9ebddfb734a8c8728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f11cd5d457de405d84e7df4634affbf0723a255f39593e21334c3cad440e40c03d635b0f8a9d6a3776700e2c10a112722fdeaa157efbdcc8f2f55352feb9ee6e"} 01:19:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:19:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:19:41 INFO - Contents: 01:19:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec8215dd0356f6165c2509b09150e7db206a1a3bc0e527069359c462399038b7000266072de42fe9f5734d16d219e371247cde21da33e16509e597a8495e1651", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b61e163a923d994f7c434539478fadebb70bc5e9d7256b79c16f1a867aaaf3138eaa471a2ce07c0e84f5b7fa042ddc5313193c7cd84e42d9ebddfb734a8c8728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f11cd5d457de405d84e7df4634affbf0723a255f39593e21334c3cad440e40c03d635b0f8a9d6a3776700e2c10a112722fdeaa157efbdcc8f2f55352feb9ee6e"} 01:19:41 INFO - Running post-run listener: copy_logs_to_upload_dir 01:19:41 INFO - Copying logs to upload dir... 01:19:41 INFO - mkdir: /builds/slave/test/build/upload/logs 01:19:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.990403 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-22 01:19:41.468619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:41.472511) ========= 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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 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/ec8215dd0356f6165c2509b09150e7db206a1a3bc0e527069359c462399038b7000266072de42fe9f5734d16d219e371247cde21da33e16509e597a8495e1651", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b61e163a923d994f7c434539478fadebb70bc5e9d7256b79c16f1a867aaaf3138eaa471a2ce07c0e84f5b7fa042ddc5313193c7cd84e42d9ebddfb734a8c8728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f11cd5d457de405d84e7df4634affbf0723a255f39593e21334c3cad440e40c03d635b0f8a9d6a3776700e2c10a112722fdeaa157efbdcc8f2f55352feb9ee6e"} build_url:https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.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/ec8215dd0356f6165c2509b09150e7db206a1a3bc0e527069359c462399038b7000266072de42fe9f5734d16d219e371247cde21da33e16509e597a8495e1651", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b61e163a923d994f7c434539478fadebb70bc5e9d7256b79c16f1a867aaaf3138eaa471a2ce07c0e84f5b7fa042ddc5313193c7cd84e42d9ebddfb734a8c8728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f11cd5d457de405d84e7df4634affbf0723a255f39593e21334c3cad440e40c03d635b0f8a9d6a3776700e2c10a112722fdeaa157efbdcc8f2f55352feb9ee6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:41.498883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:41.499347) ========= 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=826874ccc97bd7bf541b4875000001d5-1466571900.132407-1892468834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:41.582209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:19:41.582545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:19:41.582893) ========= ========= Total master_lag: 0.18 =========