builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1465908299.71 results: success (0) buildid: 20160614051127 builduid: bb1d9d30ce17449dafb6e2ef05a1b75a revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.712317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.712787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.713069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.728161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.728429) ========= 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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 05:45:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.6M=0.001s 2016-06-14 05:45:00 (10.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.834949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.835269) ========= 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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015715 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.884573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:44:59.884940) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 --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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 05:45:00,594 truncating revision to first 12 chars 2016-06-14 05:45:00,594 Setting DEBUG logging. 2016-06-14 05:45:00,594 attempt 1/10 2016-06-14 05:45:00,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5003caf3aa25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 05:45:00,919 unpacking tar archive at: fx-team-5003caf3aa25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:45:00.558423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:45:00.558765) ========= script_repo_revision: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:45:00.559168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:45:00.559441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:45:00.567262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-14 05:45:00.567588) ========= /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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:01 INFO - MultiFileLogger online at 20160614 05:45:01 in /builds/slave/test 05:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:01 INFO - {'append_to_log': False, 05:45:01 INFO - 'base_work_dir': '/builds/slave/test', 05:45:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:01 INFO - 'branch': 'Fx-Team-Non-PGO', 05:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:01 INFO - 'config_files': ('talos/linux_config.py',), 05:45:01 INFO - 'default_actions': ('clobber', 05:45:01 INFO - 'read-buildbot-config', 05:45:01 INFO - 'download-and-extract', 05:45:01 INFO - 'populate-webroot', 05:45:01 INFO - 'create-virtualenv', 05:45:01 INFO - 'install', 05:45:01 INFO - 'run-tests'), 05:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:01 INFO - 'download_minidump_stackwalk': True, 05:45:01 INFO - 'download_symbols': 'ondemand', 05:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:01 INFO - 'installer_path': 'installer.exe', 05:45:01 INFO - 'log_level': 'info', 05:45:01 INFO - 'log_name': 'talos', 05:45:01 INFO - 'log_to_console': True, 05:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:01 INFO - 'opt_config_files': (), 05:45:01 INFO - 'pip_index': False, 05:45:01 INFO - 'sps_profile': False, 05:45:01 INFO - 'sps_profile_interval': 0, 05:45:01 INFO - 'suite': 'dromaeojs-e10s', 05:45:01 INFO - 'system_bits': '32', 05:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:01 INFO - 'title': 'talos-linux64-ix-017', 05:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:01 INFO - 'use_talos_json': True, 05:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:01 INFO - 'work_dir': 'build'} 05:45:01 INFO - ##### 05:45:01 INFO - ##### Running clobber step. 05:45:01 INFO - ##### 05:45:01 INFO - Running pre-action listener: _resource_record_pre_action 05:45:01 INFO - Running main action method: clobber 05:45:01 INFO - rmtree: /builds/slave/test/build 05:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:01 INFO - Running post-action listener: _resource_record_post_action 05:45:01 INFO - ##### 05:45:01 INFO - ##### Finished clobber step (success) 05:45:01 INFO - ##### 05:45:01 INFO - ##### 05:45:01 INFO - ##### Running read-buildbot-config step. 05:45:01 INFO - ##### 05:45:01 INFO - Running pre-action listener: _resource_record_pre_action 05:45:01 INFO - Running main action method: read_buildbot_config 05:45:01 INFO - Using buildbot properties: 05:45:01 INFO - { 05:45:01 INFO - "project": "", 05:45:01 INFO - "product": "firefox", 05:45:01 INFO - "script_repo_revision": "production", 05:45:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:45:01 INFO - "repository": "", 05:45:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:45:01 INFO - "buildid": "20160614051127", 05:45:01 INFO - "pgo_build": "False", 05:45:01 INFO - "basedir": "/builds/slave/test", 05:45:01 INFO - "buildnumber": 1368, 05:45:01 INFO - "slavename": "talos-linux64-ix-017", 05:45:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:45:01 INFO - "platform": "ubuntu64_hw", 05:45:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:45:01 INFO - "branch": "fx-team", 05:45:01 INFO - "repo_path": "integration/fx-team", 05:45:01 INFO - "revision": "5003caf3aa25dad509e53c68d2ee39de58fe5ec5", 05:45:01 INFO - "stage_platform": "linux64", 05:45:01 INFO - "builduid": "bb1d9d30ce17449dafb6e2ef05a1b75a", 05:45:01 INFO - "slavebuilddir": "test" 05:45:01 INFO - } 05:45:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:45:01 INFO - Running post-action listener: _resource_record_post_action 05:45:01 INFO - ##### 05:45:01 INFO - ##### Finished read-buildbot-config step (success) 05:45:01 INFO - ##### 05:45:01 INFO - ##### 05:45:01 INFO - ##### Running download-and-extract step. 05:45:01 INFO - ##### 05:45:01 INFO - Running pre-action listener: _resource_record_pre_action 05:45:01 INFO - Running main action method: download_and_extract 05:45:01 INFO - mkdir: /builds/slave/test/build/tests 05:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:01 INFO - https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:02 INFO - Downloaded 1361 bytes. 05:45:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:45:02 INFO - Using the following test package requirements: 05:45:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'jsshell-linux-x86_64.zip'], 05:45:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:02 INFO - https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:03 INFO - Downloaded 22653673 bytes. 05:45:03 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'] 05:45:03 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 05:45:04 INFO - Return code: 0 05:45:04 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 05:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:04 INFO - https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:05 INFO - Downloaded 22653673 bytes. 05:45:05 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'] 05:45:05 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 05:45:07 INFO - Return code: 0 05:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:07 INFO - https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:08 INFO - Downloaded 14405384 bytes. 05:45:08 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'] 05:45:08 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 05:45:08 INFO - Return code: 0 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dUVGp_xyR46X51WcGzTaww/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 05:45:10 INFO - Downloaded 55397065 bytes. 05:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:10 INFO - mkdir: /builds/slave/test/properties 05:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:10 INFO - Contents: 05:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:45:11 INFO - Running post-action listener: _resource_record_post_action 05:45:11 INFO - Running post-action listener: set_extra_try_arguments 05:45:11 INFO - ##### 05:45:11 INFO - ##### Finished download-and-extract step (success) 05:45:11 INFO - ##### 05:45:11 INFO - ##### 05:45:11 INFO - ##### Running populate-webroot step. 05:45:11 INFO - ##### 05:45:11 INFO - Running pre-action listener: _resource_record_pre_action 05:45:11 INFO - Running main action method: populate_webroot 05:45:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:11 INFO - '--tppagecycles', 05:45:11 INFO - '7'], 05:45:11 INFO - 'tests': ['tsvgm']}}, 05:45:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['damp', 'tps']}, 05:45:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'tests': ['damp', 'tps']}, 05:45:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['dromaeo_dom']}, 05:45:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['basic_compositor_video']}, 05:45:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['a11yr', 05:45:11 INFO - 'ts_paint', 05:45:11 INFO - 'tpaint', 05:45:11 INFO - 'sessionrestore', 05:45:11 INFO - 'sessionrestore_no_auto_restore', 05:45:11 INFO - 'tabpaint']}, 05:45:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['tsvgx', 05:45:11 INFO - 'tsvgr_opacity', 05:45:11 INFO - 'tart', 05:45:11 INFO - 'tscrollx', 05:45:11 INFO - 'cart']}, 05:45:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:11 INFO - 'tsvgr_opacity', 05:45:11 INFO - 'tart', 05:45:11 INFO - 'tscrollx', 05:45:11 INFO - 'cart']}, 05:45:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'talos_options': ['--disable-e10s'], 05:45:11 INFO - 'tests': ['tp5o']}, 05:45:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'tests': ['tp5o']}, 05:45:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'talos_options': ['--disable-e10s', 05:45:11 INFO - '--xperf_path', 05:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:11 INFO - 'tests': ['tp5n']}, 05:45:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:11 INFO - 'talos_options': ['--xperf_path', 05:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:11 INFO - 'tests': ['tp5n']}}, 05:45:11 INFO - 'talos.zip': {'path': '', 05:45:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:11 INFO - Running post-action listener: _resource_record_post_action 05:45:11 INFO - ##### 05:45:11 INFO - ##### Finished populate-webroot step (success) 05:45:11 INFO - ##### 05:45:11 INFO - ##### 05:45:11 INFO - ##### Running create-virtualenv step. 05:45:11 INFO - ##### 05:45:11 INFO - Running pre-action listener: _resource_record_pre_action 05:45:11 INFO - Running main action method: create_virtualenv 05:45:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:45:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:11 INFO - Using real prefix '/usr' 05:45:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:13 INFO - Installing pip.................done. 05:45:13 INFO - Return code: 0 05:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:13 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:14 INFO - Cleaning up... 05:45:14 INFO - Return code: 0 05:45:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', '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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45: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 psutil>=3.1.1 05:45:14 INFO - Using env: {'DISPLAY': ':0', 05:45:14 INFO - 'HOME': '/home/cltbld', 05:45:14 INFO - 'LANG': 'en_US.UTF-8', 05:45:14 INFO - 'LANGUAGE': 'en_US:en', 05:45:14 INFO - 'LOGNAME': 'cltbld', 05:45:14 INFO - 'MAIL': '/var/mail/cltbld', 05:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:14 INFO - 'MOZ_NO_REMOTE': '1', 05:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:14 INFO - 'NO_EM_RESTART': '1', 05:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:14 INFO - 'PWD': '/builds/slave/test', 05:45:14 INFO - 'SHELL': '/bin/bash', 05:45:14 INFO - 'SHLVL': '1', 05:45:14 INFO - 'TERM': 'linux', 05:45:14 INFO - 'TMOUT': '86400', 05:45:14 INFO - 'USER': 'cltbld', 05:45:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:14 INFO - '_': '/tools/buildbot/bin/python'} 05:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:14 INFO - Downloading/unpacking psutil>=3.1.1 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:16 INFO - Installing collected packages: psutil 05:45:16 INFO - Running setup.py install for psutil 05:45:16 INFO - building 'psutil._psutil_linux' extension 05:45:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:45:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:45:16 INFO - building 'psutil._psutil_posix' extension 05:45:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:45:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:16 INFO - Successfully installed psutil 05:45:16 INFO - Cleaning up... 05:45:16 INFO - Return code: 0 05:45:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:45: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 mozsystemmonitor==0.3 05:45:16 INFO - Using env: {'DISPLAY': ':0', 05:45:16 INFO - 'HOME': '/home/cltbld', 05:45:16 INFO - 'LANG': 'en_US.UTF-8', 05:45:16 INFO - 'LANGUAGE': 'en_US:en', 05:45:16 INFO - 'LOGNAME': 'cltbld', 05:45:16 INFO - 'MAIL': '/var/mail/cltbld', 05:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:16 INFO - 'MOZ_NO_REMOTE': '1', 05:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:16 INFO - 'NO_EM_RESTART': '1', 05:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:16 INFO - 'PWD': '/builds/slave/test', 05:45:16 INFO - 'SHELL': '/bin/bash', 05:45:16 INFO - 'SHLVL': '1', 05:45:16 INFO - 'TERM': 'linux', 05:45:16 INFO - 'TMOUT': '86400', 05:45:16 INFO - 'USER': 'cltbld', 05:45:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:16 INFO - '_': '/tools/buildbot/bin/python'} 05:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:18 INFO - Installing collected packages: mozsystemmonitor 05:45:18 INFO - Running setup.py install for mozsystemmonitor 05:45:19 INFO - Successfully installed mozsystemmonitor 05:45:19 INFO - Cleaning up... 05:45:19 INFO - Return code: 0 05:45:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', '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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:45: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 jsonschema==2.5.1 05:45:19 INFO - Using env: {'DISPLAY': ':0', 05:45:19 INFO - 'HOME': '/home/cltbld', 05:45:19 INFO - 'LANG': 'en_US.UTF-8', 05:45:19 INFO - 'LANGUAGE': 'en_US:en', 05:45:19 INFO - 'LOGNAME': 'cltbld', 05:45:19 INFO - 'MAIL': '/var/mail/cltbld', 05:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:19 INFO - 'MOZ_NO_REMOTE': '1', 05:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:19 INFO - 'NO_EM_RESTART': '1', 05:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:19 INFO - 'PWD': '/builds/slave/test', 05:45:19 INFO - 'SHELL': '/bin/bash', 05:45:19 INFO - 'SHLVL': '1', 05:45:19 INFO - 'TERM': 'linux', 05:45:19 INFO - 'TMOUT': '86400', 05:45:19 INFO - 'USER': 'cltbld', 05:45:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:19 INFO - '_': '/tools/buildbot/bin/python'} 05:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:19 INFO - Downloading/unpacking jsonschema==2.5.1 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:21 INFO - warning: no files found matching '*.txt' 05:45:21 INFO - no previously-included directories found matching 'build' 05:45:21 INFO - no previously-included directories found matching 'dist' 05:45:21 INFO - no previously-included directories found matching '.git*' 05:45:21 INFO - Installing collected packages: jsonschema, functools32 05:45:21 INFO - Running setup.py install for functools32 05:45:21 INFO - warning: no files found matching '*.txt' 05:45:21 INFO - no previously-included directories found matching 'build' 05:45:21 INFO - no previously-included directories found matching 'dist' 05:45:21 INFO - no previously-included directories found matching '.git*' 05:45:21 INFO - Successfully installed jsonschema functools32 05:45:21 INFO - Cleaning up... 05:45:21 INFO - Return code: 0 05:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:21 INFO - Using env: {'DISPLAY': ':0', 05:45:21 INFO - 'HOME': '/home/cltbld', 05:45:21 INFO - 'LANG': 'en_US.UTF-8', 05:45:21 INFO - 'LANGUAGE': 'en_US:en', 05:45:21 INFO - 'LOGNAME': 'cltbld', 05:45:21 INFO - 'MAIL': '/var/mail/cltbld', 05:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:21 INFO - 'MOZ_NO_REMOTE': '1', 05:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:21 INFO - 'NO_EM_RESTART': '1', 05:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:21 INFO - 'PWD': '/builds/slave/test', 05:45:21 INFO - 'SHELL': '/bin/bash', 05:45:21 INFO - 'SHLVL': '1', 05:45:21 INFO - 'TERM': 'linux', 05:45:21 INFO - 'TMOUT': '86400', 05:45:21 INFO - 'USER': 'cltbld', 05:45:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:21 INFO - '_': '/tools/buildbot/bin/python'} 05:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:24 INFO - Downloading docopt-0.6.1.tar.gz 05:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:24 INFO - Running setup.py install for blobuploader 05:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:24 INFO - Running setup.py install for requests 05:45:25 INFO - Running setup.py install for docopt 05:45:25 INFO - Successfully installed blobuploader requests docopt 05:45:25 INFO - Cleaning up... 05:45:25 INFO - Return code: 0 05:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:25 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:25 INFO - Using env: {'DISPLAY': ':0', 05:45:25 INFO - 'HOME': '/home/cltbld', 05:45:25 INFO - 'LANG': 'en_US.UTF-8', 05:45:25 INFO - 'LANGUAGE': 'en_US:en', 05:45:25 INFO - 'LOGNAME': 'cltbld', 05:45:25 INFO - 'MAIL': '/var/mail/cltbld', 05:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:25 INFO - 'MOZ_NO_REMOTE': '1', 05:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:25 INFO - 'NO_EM_RESTART': '1', 05:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:25 INFO - 'PWD': '/builds/slave/test', 05:45:25 INFO - 'SHELL': '/bin/bash', 05:45:25 INFO - 'SHLVL': '1', 05:45:25 INFO - 'TERM': 'linux', 05:45:25 INFO - 'TMOUT': '86400', 05:45:25 INFO - 'USER': 'cltbld', 05:45:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:25 INFO - '_': '/tools/buildbot/bin/python'} 05:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:25 INFO - Running setup.py (path:/tmp/pip-rXl_ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:25 INFO - Running setup.py (path:/tmp/pip-_gWxY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:25 INFO - Running setup.py (path:/tmp/pip-YSIxHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:25 INFO - Running setup.py (path:/tmp/pip-jGysvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:25 INFO - Running setup.py (path:/tmp/pip-F_n7e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:25 INFO - Running setup.py (path:/tmp/pip-uv1pZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:25 INFO - Running setup.py (path:/tmp/pip-6kaeUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:25 INFO - Running setup.py (path:/tmp/pip-b7J0Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:25 INFO - Running setup.py (path:/tmp/pip-gYbvSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:26 INFO - Running setup.py (path:/tmp/pip-vdzkWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:26 INFO - Running setup.py (path:/tmp/pip-jJV_3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:26 INFO - Running setup.py (path:/tmp/pip-3e1K2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:26 INFO - Running setup.py (path:/tmp/pip-Jvg9My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:26 INFO - Running setup.py (path:/tmp/pip-XoOuyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:26 INFO - Running setup.py (path:/tmp/pip-pUIqZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:26 INFO - Running setup.py (path:/tmp/pip-_CVUBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:26 INFO - Running setup.py (path:/tmp/pip-6j0VV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:26 INFO - Running setup.py install for manifestparser 05:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:26 INFO - Running setup.py install for mozcrash 05:45:26 INFO - Running setup.py install for mozdebug 05:45:26 INFO - Running setup.py install for mozdevice 05:45:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for mozfile 05:45:27 INFO - Running setup.py install for mozhttpd 05:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for mozinfo 05:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for mozInstall 05:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for mozleak 05:45:27 INFO - Running setup.py install for mozlog 05:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for moznetwork 05:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Running setup.py install for mozprocess 05:45:27 INFO - Running setup.py install for mozprofile 05:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:28 INFO - Running setup.py install for mozrunner 05:45:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:28 INFO - Running setup.py install for mozscreenshot 05:45:28 INFO - Running setup.py install for moztest 05:45:28 INFO - Running setup.py install for mozversion 05:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:28 INFO - Cleaning up... 05:45:28 INFO - Return code: 0 05:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:28 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:28 INFO - Using env: {'DISPLAY': ':0', 05:45:28 INFO - 'HOME': '/home/cltbld', 05:45:28 INFO - 'LANG': 'en_US.UTF-8', 05:45:28 INFO - 'LANGUAGE': 'en_US:en', 05:45:28 INFO - 'LOGNAME': 'cltbld', 05:45:28 INFO - 'MAIL': '/var/mail/cltbld', 05:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:28 INFO - 'MOZ_NO_REMOTE': '1', 05:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:28 INFO - 'NO_EM_RESTART': '1', 05:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:28 INFO - 'PWD': '/builds/slave/test', 05:45:28 INFO - 'SHELL': '/bin/bash', 05:45:28 INFO - 'SHLVL': '1', 05:45:28 INFO - 'TERM': 'linux', 05:45:28 INFO - 'TMOUT': '86400', 05:45:28 INFO - 'USER': 'cltbld', 05:45:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:28 INFO - '_': '/tools/buildbot/bin/python'} 05:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:28 INFO - Running setup.py (path:/tmp/pip-HEWLBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:28 INFO - Running setup.py (path:/tmp/pip-y11rM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:28 INFO - Running setup.py (path:/tmp/pip-uwGwIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:28 INFO - Running setup.py (path:/tmp/pip-N_apKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:28 INFO - Running setup.py (path:/tmp/pip-3kH8ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:29 INFO - Running setup.py (path:/tmp/pip-Khsdan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:29 INFO - Running setup.py (path:/tmp/pip-kKCHCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:29 INFO - Running setup.py (path:/tmp/pip-6M4vnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:29 INFO - Running setup.py (path:/tmp/pip-uUKq3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:29 INFO - Running setup.py (path:/tmp/pip-t5PIDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:29 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)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:29 INFO - Running setup.py (path:/tmp/pip-APGn98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:29 INFO - Running setup.py (path:/tmp/pip-d0f0MM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:29 INFO - Running setup.py (path:/tmp/pip-cV8rzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:29 INFO - Running setup.py (path:/tmp/pip-eRJsdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:29 INFO - Running setup.py (path:/tmp/pip-uqTgPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:29 INFO - Running setup.py (path:/tmp/pip-UNLAek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:29 INFO - Running setup.py (path:/tmp/pip-qHWv1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:31 INFO - Downloading blessings-1.6.tar.gz 05:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:31 INFO - Installing collected packages: blessings 05:45:31 INFO - Running setup.py install for blessings 05:45:31 INFO - Successfully installed blessings 05:45:31 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:32 INFO - Reading from file tmpfile_stdout 05:45:32 INFO - Current package versions: 05:45:32 INFO - argparse == 1.2.1 05:45:32 INFO - blessings == 1.6 05:45:32 INFO - blobuploader == 1.2.4 05:45:32 INFO - docopt == 0.6.1 05:45:32 INFO - functools32 == 3.2.3-2 05:45:32 INFO - jsonschema == 2.5.1 05:45:32 INFO - manifestparser == 1.1 05:45:32 INFO - mozInstall == 1.12 05:45:32 INFO - mozcrash == 0.17 05:45:32 INFO - mozdebug == 0.1 05:45:32 INFO - mozdevice == 0.48 05:45:32 INFO - mozfile == 1.2 05:45:32 INFO - mozhttpd == 0.7 05:45:32 INFO - mozinfo == 0.9 05:45:32 INFO - mozleak == 0.1 05:45:32 INFO - mozlog == 3.2 05:45:32 INFO - moznetwork == 0.27 05:45:32 INFO - mozprocess == 0.22 05:45:32 INFO - mozprofile == 0.28 05:45:32 INFO - mozrunner == 6.11 05:45:32 INFO - mozscreenshot == 0.1 05:45:32 INFO - mozsystemmonitor == 0.3 05:45:32 INFO - moztest == 0.7 05:45:32 INFO - mozversion == 1.4 05:45:32 INFO - psutil == 3.1.1 05:45:32 INFO - requests == 1.2.3 05:45:32 INFO - wsgiref == 0.1.2 05:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:32 INFO - Using env: {'DISPLAY': ':0', 05:45:32 INFO - 'HOME': '/home/cltbld', 05:45:32 INFO - 'LANG': 'en_US.UTF-8', 05:45:32 INFO - 'LANGUAGE': 'en_US:en', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MAIL': '/var/mail/cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SHLVL': '1', 05:45:32 INFO - 'TERM': 'linux', 05:45:32 INFO - 'TMOUT': '86400', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - '_': '/tools/buildbot/bin/python'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:32 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:32 INFO - Using env: {'DISPLAY': ':0', 05:45:32 INFO - 'HOME': '/home/cltbld', 05:45:32 INFO - 'LANG': 'en_US.UTF-8', 05:45:32 INFO - 'LANGUAGE': 'en_US:en', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MAIL': '/var/mail/cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SHLVL': '1', 05:45:32 INFO - 'TERM': 'linux', 05:45:32 INFO - 'TMOUT': '86400', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - '_': '/tools/buildbot/bin/python'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:32 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x7f0f50294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, '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': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:45:32 INFO - Using env: {'DISPLAY': ':0', 05:45:32 INFO - 'HOME': '/home/cltbld', 05:45:32 INFO - 'LANG': 'en_US.UTF-8', 05:45:32 INFO - 'LANGUAGE': 'en_US:en', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MAIL': '/var/mail/cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SHLVL': '1', 05:45:32 INFO - 'TERM': 'linux', 05:45:32 INFO - 'TMOUT': '86400', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - '_': '/tools/buildbot/bin/python'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Downloading/unpacking flake8 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:35 INFO - no previously-included directories found matching 'docs/_build' 05:45:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:35 INFO - Running setup.py install for pep8 05:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:35 INFO - no previously-included directories found matching 'docs/_build' 05:45:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:35 INFO - Cleaning up... 05:45:35 INFO - Return code: 0 05:45:35 INFO - Running post-action listener: _resource_record_post_action 05:45:35 INFO - Running post-action listener: _start_resource_monitoring 05:45:35 INFO - Starting resource monitoring. 05:45:35 INFO - ##### 05:45:35 INFO - ##### Finished create-virtualenv step (success) 05:45:35 INFO - ##### 05:45:35 INFO - ##### 05:45:35 INFO - ##### Running install step. 05:45:35 INFO - ##### 05:45:35 INFO - Running pre-action listener: _resource_record_pre_action 05:45:35 INFO - Running main action method: install 05:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:36 INFO - Reading from file tmpfile_stdout 05:45:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:36 INFO - Reading from file tmpfile_stdout 05:45:36 INFO - Output received: 05:45:36 INFO - Usage: mozinstall [options] installer 05:45:36 INFO - Options: 05:45:36 INFO - -h, --help show this help message and exit 05:45:36 INFO - -d DEST, --destination=DEST 05:45:36 INFO - Directory to install application into. [default: 05:45:36 INFO - "/builds/slave/test"] 05:45:36 INFO - --app=APP Application being installed. [default: firefox] 05:45:36 INFO - mkdir: /builds/slave/test/build/application 05:45:36 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'] 05:45:36 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 05:45:52 INFO - Reading from file tmpfile_stdout 05:45:52 INFO - Output received: 05:45:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:45:52 INFO - Running post-action listener: _resource_record_post_action 05:45:52 INFO - ##### 05:45:52 INFO - ##### Finished install step (success) 05:45:52 INFO - ##### 05:45:52 INFO - ##### 05:45:52 INFO - ##### Running run-tests step. 05:45:52 INFO - ##### 05:45:52 INFO - Running pre-action listener: _resource_record_pre_action 05:45:52 INFO - Running main action method: run_tests 05:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:45:52 INFO - Python 2.7.3 05:45:52 INFO - Return code: 0 05:45:52 INFO - grabbing minidump binary from tooltool 05:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:52 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 0x2d5d1c0>, '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 0x2d5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:45:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:45:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:45:52 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 05:45:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:52 INFO - Return code: 0 05:45:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:45:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:45:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:45:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:45:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:45:53 INFO - Return code: 0 05:45:53 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/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:45:53 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/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:45:53 INFO - Using env: {'DISPLAY': ':0', 05:45:53 INFO - 'HOME': '/home/cltbld', 05:45:53 INFO - 'LANG': 'en_US.UTF-8', 05:45:53 INFO - 'LANGUAGE': 'en_US:en', 05:45:53 INFO - 'LOGNAME': 'cltbld', 05:45:53 INFO - 'MAIL': '/var/mail/cltbld', 05:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:53 INFO - 'MOZ_NO_REMOTE': '1', 05:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:53 INFO - 'NO_EM_RESTART': '1', 05:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:53 INFO - 'PWD': '/builds/slave/test', 05:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:53 INFO - 'SHELL': '/bin/bash', 05:45:53 INFO - 'SHLVL': '1', 05:45:53 INFO - 'TERM': 'linux', 05:45:53 INFO - 'TMOUT': '86400', 05:45:53 INFO - 'USER': 'cltbld', 05:45:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966', 05:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:53 INFO - '_': '/tools/buildbot/bin/python'} 05:45:53 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/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:45:53 INFO - mozversion application_buildid: 20160614051127 05:45:53 INFO - mozversion application_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 05:45:53 INFO - mozversion application_display_name: Nightly 05:45:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:53 INFO - mozversion application_name: Firefox 05:45:53 INFO - mozversion application_remotingname: firefox 05:45:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:45:53 INFO - mozversion application_vendor: Mozilla 05:45:53 INFO - mozversion application_version: 50.0a1 05:45:53 INFO - mozversion platform_buildid: 20160614051127 05:45:53 INFO - mozversion platform_changeset: 5003caf3aa25dad509e53c68d2ee39de58fe5ec5 05:45:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:45:53 INFO - mozversion platform_version: 50.0a1 05:45:53 INFO - using testdate: 1465908353 05:45:53 INFO - actual date: 1465908353 05:45:53 INFO - starting webserver on 'localhost:57399' 05:45:53 INFO - SUITE-START | Running 2 tests 05:45:53 INFO - TEST-START | dromaeo_css 05:45:53 INFO - operating with platform_type : linux_ 05:45:53 INFO - Initialising browser for dromaeo_css test... 05:45:53 INFO - TEST-INFO | started process 23084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkGogjT/profile http://localhost:57399/getInfo.html) 05:45:57 INFO - PROCESS | 23084 | __metrics Screen width/height:1600/1200 05:45:57 INFO - PROCESS | 23084 | colorDepth:24 05:45:57 INFO - PROCESS | 23084 | Browser inner width/height: 1024/697 05:45:57 INFO - PROCESS | 23084 | __metrics 05:45:58 ERROR - PROCESS | 23084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:45:59 INFO - TEST-INFO | 23084: exit 0 05:45:59 INFO - Browser initialized. 05:45:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:59 INFO - TEST-INFO | started process 23201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkGogjT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:11 INFO - PROCESS | 23201 | RSS: Main: 186408960 05:46:11 INFO - PROCESS | 23201 | 05:47:01 INFO - PROCESS | 23201 | 1465908421227 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:13 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57399/tests/dromaeo/cssquery-ext.html) 05:49:14 INFO - PROCESS | 23201 | RSS: Main: 189546496 05:49:14 INFO - PROCESS | 23201 | 05:52:17 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-ext.html (next: http://localhost:57399/tests/dromaeo/cssquery-jquery.html) 05:52:17 INFO - PROCESS | 23201 | RSS: Main: 188325888 05:52:17 INFO - PROCESS | 23201 | 05:55:19 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57399/tests/dromaeo/cssquery-mootools.html) 05:55:20 INFO - PROCESS | 23201 | RSS: Main: 189665280 05:55:20 INFO - PROCESS | 23201 | 05:58:22 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57399/tests/dromaeo/cssquery-prototype.html) 05:58:22 INFO - PROCESS | 23201 | RSS: Main: 187129856 05:58:22 INFO - PROCESS | 23201 | 06:01:25 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57399/tests/dromaeo/cssquery-yui.html) 06:01:26 INFO - PROCESS | 23201 | RSS: Main: 189259776 06:01:26 INFO - PROCESS | 23201 | 06:04:28 INFO - PROCESS | 23201 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-yui.html (next: http://localhost:57399/tests/dromaeo/cssquery-dojo.html) 06:04:29 INFO - PROCESS | 23201 | RSS: Main: 190558208 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | __start_tp_report 06:04:29 INFO - PROCESS | 23201 | _x_x_mozilla_page_load 06:04:29 INFO - PROCESS | 23201 | _x_x_mozilla_page_load_details 06:04:29 INFO - PROCESS | 23201 | |i|pagename|runs| 06:04:29 INFO - PROCESS | 23201 | |0;dojo.html;2650.9867450662746;2696.5955106733995;2700.986495067524;2726.1548919834854;2729.358600728828;4840.467548569659;4867.464578896323;4910.901781964359;4921.975390123049;4932.087563800699;4758.262469317253;4871.464138944713;4916.3117163597035;4930.433000204977;4979.751012449372;4487.640988720903;4537.591616754491;4589.24277494213;4627.097715945392;4661.230896902007;4470.217711900421;4637.327587499811;4651.302304654295;4681.555252251031;4693.624510039206;4305.22505948929;4505.504394516601;4564.7717614119165;4604.953950460503;4606.585407313358;4476.485204201526;4486.955130448687;4516.728996260202;4523.864284071483;4540;4490.2142125127975;4492.707973981681;4505.752183629899;4536.183486972343;4552.248878934972;4775.474697783241;4827.8551643450755;4847.927281090787;4887.291342755316;4902.583280421169;5206.895862082775;5220.556252718524;5222;5224.294720212799;5224.346956630421;5210.244514545369;5248.291480650101;5255.0278198533015;5258.8685282867855;5294.735263236861;4716.764161791897;4892.143874821928;4958.107540642719;4961.925571116436;4969.552740253394;5396.244525766396;5409.134538473825;5415.972920135374;5422.8915421691345;5428.077226871363;4968.205087186105;5180.507851754077;5188.558972487305;5223.451537588575;5241.659292145999;5236.6857988520815;5254.500822421864;5273.894522109613;5303.973480132575;5323.334583177103;5005.099082165245;5061.822836200715;5126.8974620508125;5170.069387510209;5181.922271165936;5147.356580427447;5156.5616922562;5157.871053223625;5161.896762064737;5200.323957885451;4299.699021068558;4346.826126954949;4349.043210493686;4383.276759334738;4384.934225986613;3847.2882516734494;3879.86420475282;3898.4542164097047;3902.2195560887935;3932.941005884914;4610.124076425468;4614.607758340579;4617.538246175355;4622.306654001926;4655.092257009851;5019.774110165052;5240.371155461369;5329.946700532945;5344.35867695879;5357.812476563379;4574.81700731967;4586.082783443325;4592.928965293585;4599.609033232213;4640.721556706609;4729.787159577827;4736.976315118402;4737.336772851803;4742.691725037862;4770.069836381872;4732.361131247238;4887.853364399074;4950.900981980412;4982.177940639826;4992.251162325608;5283.1546952487415;5296.841094767163;5299.258103865539;5307.601929855199;5350.03699334108;4934.358533390637;4952.059108769322;4954.405471343318;4970.080535101018;4992.900141997213;5030.170021946338;5189.714565698923;5199.4020687621405;5243.475652434726;5258.50044245796;5322;5327.866803329948;5337.946620533745;5339.252504649275;5340.145576707708;5178.352705911761;5183.948160518346;5184.429712731672;5195;5237.921431178459;4899.559039686303;4915.975420122876;5066.341375621293;5077.898442031064;5139.383274006994;4987.12725273083;5013.097642424253;5016.097102521435;5051.87370315745;5052.823151189691;5239.44985776488;5243.449437808975;5245.475452454877;5247.658902171499;5270.8155214567305;4804.543568361;5001.799928002984;5053.494650534917;5082.491750824888;5094.414142373675 06:04:29 INFO - PROCESS | 23201 | |1;ext.html;542.8998271703787;581.8603535151564;603.3785201242719;607.9635221886687;611.9841063834036;34819.30361392774;38758.61241387589;38783.224335513274;38825.61174388255;38974.61025389749;38494.23011539767;38857.22285554295;39021.60978390215;39026.80486597563;39054.8047259764;7957.045154581444;7980.640871160812;8018.518888866657;8028.879566806502;8114.6754129834735;7777.18339574345;7797.844043119134;7816.921830781676;7830.138684744674;7846.6469008894455;7834.412419068564;7908.960455197716;7915.366770658362;7939.325157361631;7958.124606293303;7789.454738168331;7855.921440785576;7878.4485086044;7887.29014388702;7895.24995125465;7937.404694647925;7989.760307190793;7999.320057795095;8020.67917283308;8036.437449378546;30101;37443;38057.42913856294;38117;38150.80924595387;3014.623172103487;3027.8334691591954;3176.5552822604855;3214.2928555717704;3647.4893514907935;28349.716502834915;30779.84610076935;31179.844100779577;31300.217494562592;31442.21394465134;3482.6343233960574;3516.944916525058;3534.1164708822794;3550.538430004083;3550.8579656813695;252571;258731;259488;259495;259665.9999999981;33252.83373583117;34134.658653413644;34159.65840341614;55818.441815581325;57278;34603.82698086544;34677;34882.825585871906;34910.12724681903;34943.475847862304;13078.626744191914;13155;13219.867801322056;13222.338883055809;13227.404766785517;10663.680089597325;10689.732756680989;10698.251122421356;10705.30415523004;10730.839037414446;8071.919280807234;8090.433669643068;8120.106788253287;8180.345572354197;8247.092819789817;3190.1546090286092;3214.5821043264696;3214.8231847248157;3246.4318744219668;3275.625171750462;903.6340282185594;907.3331101640289;920.2040235196507;945.177695405002;966.5312323523086;28060.85969570139;28731.425371492453;28828.42343153167;29168.854155729085;29225.269368265963;899.2805755395657;951.148721893915;972.9708108756748;1005.1054561440324;1084.0189628386165;14985.325660345092;15228.46700365482;15437.30532126057;15710.9214453927;15792.60518487047;682789;699016;702444;705783;706707;51581.22628160581;52278.73860630749;52426.47573524292;52551.737241313545;52775.47224527706;1174.3775798826637;1191.195942738648;1200.0339726520235;1216.951321947112;1221.8900298972958;27882.721172788013;29052.709472905;29593.85203073971;30036.849815750782;30420.84789576038;44673.77663111794;44739.77630111828;44916.326255106855;45014.77492612516;45421;363039;364389;364802;366608;367506;25729.485410292065;25949.610755839054;26387.076452324076;26706.59940100861;26796.464070718088;40798.184036319704;41267;41509.58490415057;41587.7920610395;41933.79033104815;34096.31807363888;34139;34256.82871585626;34751.826240868635;34776.47835282524;34449.794257200876;35230.823845881634;35433;35540;35691.821540893165;31352.258564271826;34645.13387165341;34817.1295717599;36156.81921590375;37103.6289637111;32739.836300818344;34094.31811363808;34530.65469345274;34884.651153489154;34941.650583493836;26636.866815666574;26699.466010680066;26730.866345668146;26776.732232677423;26812.329691757863 06:04:29 INFO - PROCESS | 23201 | |2;jquery.html;363.74901318090514;365.9176685245819;369.40156945747884;379.47821745100487;382.27558776119236;15981.760273595906;17402.738958915612;17565.912170439162;17848.910755446206;18058.82617629853;15903.761443578356;16621.41825036124;17635.470935871912;17805.46583602491;17851.64296714068;4972.900541989158;5137.3064636274;5171.22431635254;5178.585713142939;5178.637495375326;3741.8316175772156;5089.694618322894;5724.542036637059;6105;6109.5723299369065;6038.033914573669;6041.788537401192;6054;6077.665728384937;6085.269767627891;4860.416749989989;5127.179651255799;5152.433232344439;5202.661826981234;5225.268462415265;4558.772061396917;4826.420829500483;4847.030593881203;5184.274201611777;5207.739613019334;11980.880191198064;12089.697757556132;12150.513979440811;13403;20672.689909651366;1916.7604049493814;1921.1834970137775;1969.5470041890446;1980.633582787189;2008.8895110768901;8817.86773198396;8956.238719708768;8972.50651214183;9035.864462033074;9308.488033158173;1640.4750479846455;1642.868570514356;1685.8904171228953;1803.2877013579694;1828.1133650179786;68240.9999999995;68528.31471685319;69032.654836726;69686;70305;10022.649207277711;10061.887003729298;10097.798044039226;10156.441395723159;10175.44035078063;13707.657308567366;13846.584602461942;13850.16898986064;13877.653058673613;13900.51348202808;7297.598632075181;7342.816429589303;7370.77887663371;7463.2163622818825;7472.476926615193;6834.794956151323;6857.519973601899;6870;6906.758263460855;6945.131858517685;4107.63031327176;4154.937675934863;4163.02168990287;4181.581841815855;4185.602367775056;1663.717168081429;1671.2562909505396;1807.4216250799882;1906.6282074995243;1935.2549268531436;741.2957690194229;901.0223907060781;922.5110691333604;927.3230541704594;928.7445952363154;16775.580610484834;16863.662726745395;16919.154042297836;17119.315227390765;17199.57001074983;826.9710560130487;829.784256093408;844.2950136635855;857.4769390671685;869.5347988825948;9447.149756521945;9575.281853860988;9582.808343833223;9641.903580964101;9898.604055837686;408390;409819;415153;415261;418890;79018.6049069751;80261.59869200733;80966;81945.18054819494;82349.58825205835;853.3216093205916;889.6485888074175;890.2966656341417;890.857462805948;895.5790778334173;15258.237088145326;15334.463293784664;15411.152386618394;15617;15680.843191567938;26630.600540992287;27718.307042323297;34371.828140859136;35353.82323088368;37024.62975370319;44078.55921440873;46036;48991.75504122599;50453.74773126111;51184;6711.563748356537;7070.71717131309;7077.539959902796;7517.361024312994;7591.278828511283;11162;11965.162438629213;12003.699907502383;12097.697557561132;12353.876461235632;9908.455034973145;9980.101790838859;10511.211659125443;10656.094231990368;10979.725506862393;9182.95408522953;9831.459269740233;10076.748081298027;10285.177185824967;10404.11565016982;9820.607175712892;9972.650957216463;10471.162307015267;10541;10694.251402401756;7287.1984081752025;7359.264073592598;7468.10382754073;7476.439267054884;7507.962460187664;8584.699535516227;10327.690169294932;10333.74165645865;10389.740256493647;10463.319884207502 06:04:29 INFO - PROCESS | 23201 | |3;mootools.html;1369.520667766282;1406.303879579608;1473.4400927647498;1700.70237708401;1702.9063401512913;7045.365917067463;7537.585432801194;7611.657475413605;8099.676012959482;8114.715984940521;7563.394928405728;7894.17111203324;7957.403194760387;7960.2437768412055;7962.283394494494;2245.4610893385593;2281.7490076091617;2281.897314620846;2294.105298933417;2295.82781291403;2248.235599896035;2267.4104732769515;2312.190733243368;2317.1194945920524;2319.988400058006;2254.6618007298953;2263.298377502971;2268.6710426988075;2271.82961277904;2280.2133264023887;2119.9258025969093;2123.6814477828448;2125.128697234127;2134.157007981846;2143.346279384787;2162.0270878104916;2173.576152650234;2174.3150907464096;2174.423777698911;2177.8148857347146;7826.804329891798;7970.880436793453;8025.555400027993;8073.798155046112;8079.111297757242;4569.2003899317815;4583.770811459413;4621.792019359137;4626.282926146453;4666.463356713987;2867.641544806899;3003.819770813758;3070.186400603842;3072.6312842458824;3074.738647214989;978.4422878958997;1015.9288849780519;1018.2821111116644;1035.1873779083458;1039.438703100325;10758.246922715412;10772.569097236023;10827.67516974492;10837.891621083767;10850.891491085067;4221.197972385237;4312.5903039211225;4387.912241755147;4412.558744125562;4446.466424029137;9152.95423522878;9154.771130721785;9179.58691858868;9180.31147663928;9190;4669.276262179367;4682.719036857799;4692.812287508462;4705.858824235278;4724.574788269072;3726.6459686329754;4145.502539695256;4156.896077598084;4259.61663450291;4301.612854843079;3768.1144930941205;3769.1896242308035;3826.234753049401;3839.865604703822;3907.492026036597;1193.3555879824798;1224.908131890112;1228.2323547782637;1234.234774439835;1237.5482948723652;830.6469750356074;847.5931552854664;850.8085680721788;857.5583574459158;860.5525126933959;5227.372715274191;5387.838364849061;5443.7822487100075;5490.423505531941;5519.944800551943;406.13898535105767;408.2243736899914;415.6820032675006;422.358015815958;422.92175947449823;3752.6434988676033;3793.430985352219;3815.08437974884;3855.768653880776;3893.7469064510715;9198.586063627154;9523.047695230422;9715.514224288758;9759.707208783748;9855.162311203629;9727.416355018722;9731.756706082262;9735.26985476078;9764;9765.951170244245;7270.527415717961;7390.150132734804;7395.556266624019;7432.739854105189;7485.737999170112;5206.8958620828125;5230.686158830483;5257.39539952895;5417.864553386197;5480.753366098455;8872.64509419616;9037.864432033657;9141.862872056792;9171.037041110587;9184.12750788674;8668.609912554077;8934.955325223333;9034.683786067457;9124;9287.164155226063;6110.175126357884;6363.3636636336;6529.118568993125;6627.768028118992;6753.797386078426;7661.6552255147535;7663.578503182155;7687.769366919001;7688.923110768821;7711.575863327571;6579.506537009839;6756.69594868242;6813.3527314905;6869.931300687129;6892.276310987274;6647.102641143384;6669.233038200669;6673.866522669617;6728.831779205559;6834.521583489108;6350.555461117678;6685.732570697118;6703.966480167763;6726.630035347907;6770.255271920183;4714.4106986626675;4781;4827.541383568555;4857.854264372075;4919.311296418433;4530.252508336088;4546.386237857847;4582.725036497821;4619.376384188226;4743.786529606245 06:04:29 INFO - PROCESS | 23201 | |4;prototype.html;301.5115512869152;303.03030303030295;304.5614315385844;308.1602632825549;311.36481577581736;5082.822101226458;5101.336826212591;5137.383513978323;5137.7944882204665;5159.922601160985;5001.349824522807;5020.297158397827;5052.974735126329;5061.316722242496;5090.287359769626;3720.869769558066;3845.4231865220163;3985.8405663773415;3988.78061706606;3991.800409979504;3966.424868394081;3989.2021595680835;3992.141689536749;3994;3997.4403583498333;3973.5231772187235;4005.919881602381;4010.498687664042;4011.3982902564703;4028.45615841862;3718.86983955563;3931.2334094851517;3944.7633142011573;4000.6797756740207;4029.717919745619;3411.3177364527196;3415.419378705601;3418.9145271368166;3419.5725534308212;3445.414279572479;4942.703437793743;4947.381577302837;5009.12340340439;5011.398632164127;5030.2897015014705;4234.49675365244;4456.685277843044;4471.262241730111;4480.843170489017;4499.280115181556;5300.522952934216;5304.336957880265;5308.9469105308835;5309.442508536626;5349.7057661828585;3711.6845068169237;3730.0674831292176;3731.7574357666663;3735.701143908508;3741.7754934704003;5409.323834520685;5562.9443705563235;5606.411326810708;5645.830625081254;5666.886662266773;3770.377887648562;3780;3783.2244389900006;3788.45067465216;3789.2989796887664;3839.9424008639894;3845.442410850411;3847.2690188864026;3850.5956874528333;3855.4216867469545;4435.467743870691;4437.134758722083;4447.644188464915;4457.866264012085;4466.821327146943;5232.189010703347;5245.186996015624;5336.359636843604;5358.223057656618;5387.9461205388225;1309.8100775387516;1325.5683861429634;1325.7083441642824;1335.9846516647417;1337.2177276293282;828.6850996621246;837.6858677995751;863.4215075899162;867.2541614211773;874.807542340684;4656.464506581787;4657.301404789241;4683.548100088983;4684;4692.601128904013;5354.250404943311;5419.810306639249;5421.484958928895;5422;5446.373667028263;4552.430946131733;4606.516315786861;4664.230401983703;4692.976535117371;4693.9765301173275;2896.116684411275;2909.7090290971155;2915.8250504969346;2919.8102123361914;2928.7217714317107;5055.75019116497;5074.2895994560795;5094;5097.362829646294;5105.9489405106215;5334.813281535127;5536.307961504812;5546.944530554642;5552.916706249329;5630.774769009276;5060.544550990428;5068.189089745697;5082.517160869711;5092.28707980883;5117.7717347835505;5407.188921661782;5440.796477426648;5459.426760190123;5472.233887255867;5474.0967740323995;5049.545540901337;5353.330833645794;5375.892482150413;5424.403315635198;5453.481919217668;5196.870078247923;5223.817166399158;5225.6603320784025;5227.294315267391;5256.526912577886;3782;3786.072412259014;3789.1663833956486;3810.276047551067;3812.580616132279;5276.841694749163;5564.221009058654;5568.387477377566;5583.385827558884;5643.633163844337;5394.541463975449;5420.457954204548;5422.915416916553;5426.561961080396;5441.5102640762525;5147.459516750687;5348.117560602613;5410.810621628224;5415.619017150601;5422.891542169214;5214.904869977196;5223.373195216598;5248.816291429782;5263.605229607718;5284.9471505284455;5164.302819119371;5246.711430871186;5427;5446.509814116748;5462.6995515247045;5297.8145764898045;5300.257963884982;5307.389650190277;5308.372355683961;5331.600129990344 06:04:29 INFO - PROCESS | 23201 | |5;yui.html;668.8327918020495;684.19265266985;690.1786873620391;710.3429327871718;720.5640587444595;12178.512859485621;13112.47550097995;13135.474581016771;13151.27667978262;13175.077744557897;13484.393202305895;14238.359273832677;14275.428982840675;14853.851461485381;14875;626.2422468812742;797.8005498625358;802.3621221129216;804.6700852650414;805.5972013992974;791.4222617489236;809.1099790230758;810.8337790752911;817.8364327134597;820.3027426687298;822.6791551294999;824.8556502612049;826.9503829770233;827.954462504562;828.2380210206594;822.8560001999656;824.04410883375;824.2293455619016;825.0717942314895;826.0129145670926;593.7803012885217;599.2269971736455;599.6192417814719;600.213720026762;602.3103546439303;13512.986526010589;13622.318884055856;13642.727145457135;13645.317734113254;13707.794383084261;12725.172863763826;13055.281959492224;13083.672908177277;13105;13189.736205275936;10451.425171615558;10493.790124197474;10569.78860422795;10598.947005264925;10658.253922225447;3236.4821628539557;3305.173706573357;3321.2029113012945;3344.9331013379597;3349.547811045502;62417.37582624207;62852.37147628511;63788.043179352346;64096.679516602584;64282.35717642857;9718.271129665303;9868.457234852152;9919.305648604528;9985.700428987142;10041;17022.57443563921;18087.18607662658;18093.54766130831;19137.425877223704;19143.61712765737;6768.796936091925;6780.559263647847;6842.623655698885;7122.326253330463;7173.6771845267085;3513.4554144107706;3541.769784963969;3679.7424180307657;3702.629737026276;3767.434884767307;2981.150372143972;3024.803387779787;3077.5229839374933;3080.4609193391516;3084.922876928095;525.408914970658;535.4484880573016;545.18222666001;546.8359492152339;559.0803128853095;455.92021396255524;473.5312041079375;537.7391964897022;552.8203333916493;557.7322885015134;7499.662515186829;7504.512206706547;7665.884635563589;7683.346915512244;7732.7680169595005;510.37224214216724;514.452108504449;522.9816956406584;543.451164182078;556.5130510803048;3520.2431477232517;3562.323158599858;3586.1214002569536;3670.1925576373155;3716.646918542734;91525.54237228772;93289.5335523318;93868.53065734764;95222.52388738011;96808;82737;84769.15230847737;84829.15170848336;85206;86163.13836861677;64231.35768642254;71130.2886971134;71285.64357178181;73918.99999999892;74821.87767183497;6816.204147999257;6846.246912839484;7009.9649501752165;7030.648467576499;7146.3568278855155;41698.791506042275;43197.352039718804;44035.37628548956;44184.779076104416;44376;53261.7336913313;62109.37890621036;62255;62773.68613156905;63485;9482.288828337765;9734.41593504392;9780.804383912424;9830.311878168459;10028.247881408777;10807.405592692163;10830.67507974762;10885.129189664965;11062.17033722458;11265.549378024787;9171.724848254564;9316.580753866228;9333;9380.765480863032;9414.2468602513;10003.449810260505;10084.747881303027;10152.49237538135;10317.48412579383;10556.630517931835;8805.339599530189;8816.559172041501;8887.600057997277;8961.775955601162;9104.681336153468;8632.741017769476;8804.339674524565;9069.954650226706;9306.225947019737;9306.348555601044;7697.8845317319165;7715.421343399155;7888.447808653339;7897.328727058264;8005.279524842792 06:04:29 INFO - PROCESS | 23201 | __end_tp_report 06:04:29 INFO - PROCESS | 23201 | __start_cc_report 06:04:29 INFO - PROCESS | 23201 | _x_x_mozilla_cycle_collect,405 06:04:29 INFO - PROCESS | 23201 | __end_cc_report 06:04:29 INFO - PROCESS | 23201 | __startTimestamp1465909469009__endTimestamp 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | ------- Summary: start ------- 06:04:29 INFO - PROCESS | 23201 | Number of tests: 6 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#0] dojo.html Cycles:165 Average:4855.91 Median:4968.21 stddev:513.73 (10.3%) stddev-sans-first:485.31 06:04:29 INFO - PROCESS | 23201 | Values: 2651.0 2696.6 2701.0 2726.2 2729.4 4840.5 4867.5 4910.9 4922.0 4932.1 4758.3 4871.5 4916.3 4930.4 4979.8 4487.6 4537.6 4589.2 4627.1 4661.2 4470.2 4637.3 4651.3 4681.6 4693.6 4305.2 4505.5 4564.8 4605.0 4606.6 4476.5 4487.0 4516.7 4523.9 4540.0 4490.2 4492.7 4505.8 4536.2 4552.2 4775.5 4827.9 4847.9 4887.3 4902.6 5206.9 5220.6 5222.0 5224.3 5224.3 5210.2 5248.3 5255.0 5258.9 5294.7 4716.8 4892.1 4958.1 4961.9 4969.6 5396.2 5409.1 5416.0 5422.9 5428.1 4968.2 5180.5 5188.6 5223.5 5241.7 5236.7 5254.5 5273.9 5304.0 5323.3 5005.1 5061.8 5126.9 5170.1 5181.9 5147.4 5156.6 5157.9 5161.9 5200.3 4299.7 4346.8 4349.0 4383.3 4384.9 3847.3 3879.9 3898.5 3902.2 3932.9 4610.1 4614.6 4617.5 4622.3 4655.1 5019.8 5240.4 5329.9 5344.4 5357.8 4574.8 4586.1 4592.9 4599.6 4640.7 4729.8 4737.0 4737.3 4742.7 4770.1 4732.4 4887.9 4950.9 4982.2 4992.3 5283.2 5296.8 5299.3 5307.6 5350.0 4934.4 4952.1 4954.4 4970.1 4992.9 5030.2 5189.7 5199.4 5243.5 5258.5 5322.0 5327.9 5337.9 5339.3 5340.1 5178.4 5183.9 5184.4 5195.0 5237.9 4899.6 4916.0 5066.3 5077.9 5139.4 4987.1 5013.1 5016.1 5051.9 5052.8 5239.4 5243.4 5245.5 5247.7 5270.8 4804.5 5001.8 5053.5 5082.5 5094.4 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#1] ext.html Cycles:180 Average:56490.01 Median:3550.70 stddev:129245.81 (3640.0%) stddev-sans-first:129540.11 06:04:29 INFO - PROCESS | 23201 | Values: 542.9 581.9 603.4 608.0 612.0 34819.3 38758.6 38783.2 38825.6 38974.6 38494.2 38857.2 39021.6 39026.8 39054.8 7957.0 7980.6 8018.5 8028.9 8114.7 7777.2 7797.8 7816.9 7830.1 7846.6 7834.4 7909.0 7915.4 7939.3 7958.1 7789.5 7855.9 7878.4 7887.3 7895.2 7937.4 7989.8 7999.3 8020.7 8036.4 30101.0 37443.0 38057.4 38117.0 38150.8 3014.6 3027.8 3176.6 3214.3 3647.5 28349.7 30779.8 31179.8 31300.2 31442.2 3482.6 3516.9 3534.1 3550.5 3550.9 252571.0 258731.0 259488.0 259495.0 259666.0 33252.8 34134.7 34159.7 55818.4 57278.0 34603.8 34677.0 34882.8 34910.1 34943.5 13078.6 13155.0 13219.9 13222.3 13227.4 10663.7 10689.7 10698.3 10705.3 10730.8 8071.9 8090.4 8120.1 8180.3 8247.1 3190.2 3214.6 3214.8 3246.4 3275.6 903.6 907.3 920.2 945.2 966.5 28060.9 28731.4 28828.4 29168.9 29225.3 899.3 951.1 973.0 1005.1 1084.0 14985.3 15228.5 15437.3 15710.9 15792.6 682789.0 699016.0 702444.0 705783.0 706707.0 51581.2 52278.7 52426.5 52551.7 52775.5 1174.4 1191.2 1200.0 1217.0 1221.9 27882.7 29052.7 29593.9 30036.8 30420.8 44673.8 44739.8 44916.3 45014.8 45421.0 363039.0 364389.0 364802.0 366608.0 367506.0 25729.5 25949.6 26387.1 26706.6 26796.5 40798.2 41267.0 41509.6 41587.8 41933.8 34096.3 34139.0 34256.8 34751.8 34776.5 34449.8 35230.8 35433.0 35540.0 35691.8 31352.3 34645.1 34817.1 36156.8 37103.6 32739.8 34094.3 34530.7 34884.7 34941.7 26636.9 26699.5 26730.9 26776.7 26812.3 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#2] jquery.html Cycles:180 Average:24673.35 Median:25297.39 stddev:68204.40 (269.6%) stddev-sans-first:68371.30 06:04:29 INFO - PROCESS | 23201 | Values: 363.7 365.9 369.4 379.5 382.3 15981.8 17402.7 17565.9 17848.9 18058.8 15903.8 16621.4 17635.5 17805.5 17851.6 4972.9 5137.3 5171.2 5178.6 5178.6 3741.8 5089.7 5724.5 6105.0 6109.6 6038.0 6041.8 6054.0 6077.7 6085.3 4860.4 5127.2 5152.4 5202.7 5225.3 4558.8 4826.4 4847.0 5184.3 5207.7 11980.9 12089.7 12150.5 13403.0 20672.7 1916.8 1921.2 1969.5 1980.6 2008.9 8817.9 8956.2 8972.5 9035.9 9308.5 1640.5 1642.9 1685.9 1803.3 1828.1 68241.0 68528.3 69032.7 69686.0 70305.0 10022.6 10061.9 10097.8 10156.4 10175.4 13707.7 13846.6 13850.2 13877.7 13900.5 7297.6 7342.8 7370.8 7463.2 7472.5 6834.8 6857.5 6870.0 6906.8 6945.1 4107.6 4154.9 4163.0 4181.6 4185.6 1663.7 1671.3 1807.4 1906.6 1935.3 741.3 901.0 922.5 927.3 928.7 16775.6 16863.7 16919.2 17119.3 17199.6 827.0 829.8 844.3 857.5 869.5 9447.1 9575.3 9582.8 9641.9 9898.6 408390.0 409819.0 415153.0 415261.0 418890.0 79018.6 80261.6 80966.0 81945.2 82349.6 853.3 889.6 890.3 890.9 895.6 15258.2 15334.5 15411.2 15617.0 15680.8 26630.6 27718.3 34371.8 35353.8 37024.6 44078.6 46036.0 48991.8 50453.7 51184.0 6711.6 7070.7 7077.5 7517.4 7591.3 11162.0 11965.2 12003.7 12097.7 12353.9 9908.5 9980.1 10511.2 10656.1 10979.7 9183.0 9831.5 10076.7 10285.2 10404.1 9820.6 9972.7 10471.2 10541.0 10694.3 7287.2 7359.3 7468.1 7476.4 7508.0 8584.7 10327.7 10333.7 10389.7 10463.3 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#3] mootools.html Cycles:180 Average:5206.88 Median:4804.27 stddev:2906.30 (60.5%) stddev-sans-first:2900.14 06:04:29 INFO - PROCESS | 23201 | Values: 1369.5 1406.3 1473.4 1700.7 1702.9 7045.4 7537.6 7611.7 8099.7 8114.7 7563.4 7894.2 7957.4 7960.2 7962.3 2245.5 2281.7 2281.9 2294.1 2295.8 2248.2 2267.4 2312.2 2317.1 2320.0 2254.7 2263.3 2268.7 2271.8 2280.2 2119.9 2123.7 2125.1 2134.2 2143.3 2162.0 2173.6 2174.3 2174.4 2177.8 7826.8 7970.9 8025.6 8073.8 8079.1 4569.2 4583.8 4621.8 4626.3 4666.5 2867.6 3003.8 3070.2 3072.6 3074.7 978.4 1015.9 1018.3 1035.2 1039.4 10758.2 10772.6 10827.7 10837.9 10850.9 4221.2 4312.6 4387.9 4412.6 4446.5 9153.0 9154.8 9179.6 9180.3 9190.0 4669.3 4682.7 4692.8 4705.9 4724.6 3726.6 4145.5 4156.9 4259.6 4301.6 3768.1 3769.2 3826.2 3839.9 3907.5 1193.4 1224.9 1228.2 1234.2 1237.5 830.6 847.6 850.8 857.6 860.6 5227.4 5387.8 5443.8 5490.4 5519.9 406.1 408.2 415.7 422.4 422.9 3752.6 3793.4 3815.1 3855.8 3893.7 9198.6 9523.0 9715.5 9759.7 9855.2 9727.4 9731.8 9735.3 9764.0 9766.0 7270.5 7390.2 7395.6 7432.7 7485.7 5206.9 5230.7 5257.4 5417.9 5480.8 8872.6 9037.9 9141.9 9171.0 9184.1 8668.6 8935.0 9034.7 9124.0 9287.2 6110.2 6363.4 6529.1 6627.8 6753.8 7661.7 7663.6 7687.8 7688.9 7711.6 6579.5 6756.7 6813.4 6869.9 6892.3 6647.1 6669.2 6673.9 6728.8 6834.5 6350.6 6685.7 6704.0 6726.6 6770.3 4714.4 4781.0 4827.5 4857.9 4919.3 4530.3 4546.4 4582.7 4619.4 4743.8 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#4] prototype.html Cycles:180 Average:4407.65 Median:5060.93 stddev:1298.67 (25.7%) stddev-sans-first:1265.21 06:04:29 INFO - PROCESS | 23201 | Values: 301.5 303.0 304.6 308.2 311.4 5082.8 5101.3 5137.4 5137.8 5159.9 5001.3 5020.3 5053.0 5061.3 5090.3 3720.9 3845.4 3985.8 3988.8 3991.8 3966.4 3989.2 3992.1 3994.0 3997.4 3973.5 4005.9 4010.5 4011.4 4028.5 3718.9 3931.2 3944.8 4000.7 4029.7 3411.3 3415.4 3418.9 3419.6 3445.4 4942.7 4947.4 5009.1 5011.4 5030.3 4234.5 4456.7 4471.3 4480.8 4499.3 5300.5 5304.3 5308.9 5309.4 5349.7 3711.7 3730.1 3731.8 3735.7 3741.8 5409.3 5562.9 5606.4 5645.8 5666.9 3770.4 3780.0 3783.2 3788.5 3789.3 3839.9 3845.4 3847.3 3850.6 3855.4 4435.5 4437.1 4447.6 4457.9 4466.8 5232.2 5245.2 5336.4 5358.2 5387.9 1309.8 1325.6 1325.7 1336.0 1337.2 828.7 837.7 863.4 867.3 874.8 4656.5 4657.3 4683.5 4684.0 4692.6 5354.3 5419.8 5421.5 5422.0 5446.4 4552.4 4606.5 4664.2 4693.0 4694.0 2896.1 2909.7 2915.8 2919.8 2928.7 5055.8 5074.3 5094.0 5097.4 5105.9 5334.8 5536.3 5546.9 5552.9 5630.8 5060.5 5068.2 5082.5 5092.3 5117.8 5407.2 5440.8 5459.4 5472.2 5474.1 5049.5 5353.3 5375.9 5424.4 5453.5 5196.9 5223.8 5225.7 5227.3 5256.5 3782.0 3786.1 3789.2 3810.3 3812.6 5276.8 5564.2 5568.4 5583.4 5643.6 5394.5 5420.5 5422.9 5426.6 5441.5 5147.5 5348.1 5410.8 5415.6 5422.9 5214.9 5223.4 5248.8 5263.6 5284.9 5164.3 5246.7 5427.0 5446.5 5462.7 5297.8 5300.3 5307.4 5308.4 5331.6 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - PROCESS | 23201 | [#5] yui.html Cycles:180 Average:17159.74 Median:31521.81 stddev:24933.48 (79.1%) stddev-sans-first:24972.68 06:04:29 INFO - PROCESS | 23201 | Values: 668.8 684.2 690.2 710.3 720.6 12178.5 13112.5 13135.5 13151.3 13175.1 13484.4 14238.4 14275.4 14853.9 14875.0 626.2 797.8 802.4 804.7 805.6 791.4 809.1 810.8 817.8 820.3 822.7 824.9 827.0 828.0 828.2 822.9 824.0 824.2 825.1 826.0 593.8 599.2 599.6 600.2 602.3 13513.0 13622.3 13642.7 13645.3 13707.8 12725.2 13055.3 13083.7 13105.0 13189.7 10451.4 10493.8 10569.8 10598.9 10658.3 3236.5 3305.2 3321.2 3344.9 3349.5 62417.4 62852.4 63788.0 64096.7 64282.4 9718.3 9868.5 9919.3 9985.7 10041.0 17022.6 18087.2 18093.5 19137.4 19143.6 6768.8 6780.6 6842.6 7122.3 7173.7 3513.5 3541.8 3679.7 3702.6 3767.4 2981.2 3024.8 3077.5 3080.5 3084.9 525.4 535.4 545.2 546.8 559.1 455.9 473.5 537.7 552.8 557.7 7499.7 7504.5 7665.9 7683.3 7732.8 510.4 514.5 523.0 543.5 556.5 3520.2 3562.3 3586.1 3670.2 3716.6 91525.5 93289.5 93868.5 95222.5 96808.0 82737.0 84769.2 84829.2 85206.0 86163.1 64231.4 71130.3 71285.6 73919.0 74821.9 6816.2 6846.2 7010.0 7030.6 7146.4 41698.8 43197.4 44035.4 44184.8 44376.0 53261.7 62109.4 62255.0 62773.7 63485.0 9482.3 9734.4 9780.8 9830.3 10028.2 10807.4 10830.7 10885.1 11062.2 11265.5 9171.7 9316.6 9333.0 9380.8 9414.2 10003.4 10084.7 10152.5 10317.5 10556.6 8805.3 8816.6 8887.6 8961.8 9104.7 8632.7 8804.3 9070.0 9306.2 9306.3 7697.9 7715.4 7888.4 7897.3 8005.3 06:04:29 INFO - PROCESS | 23201 | -------- Summary: end -------- 06:04:29 INFO - PROCESS | 23201 | 06:04:29 INFO - TEST-INFO | 23201: exit 0 06:04:29 INFO - TEST-OK | dromaeo_css | took 1116541ms 06:04:29 INFO - TEST-START | kraken 06:04:29 INFO - operating with platform_type : linux_ 06:04:29 INFO - Initialising browser for kraken test... 06:04:29 INFO - TEST-INFO | started process 23439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdsw5T/profile http://localhost:57399/getInfo.html) 06:04:34 INFO - PROCESS | 23439 | __metrics Screen width/height:1600/1200 06:04:34 INFO - PROCESS | 23439 | colorDepth:24 06:04:34 INFO - PROCESS | 23439 | Browser inner width/height: 1024/697 06:04:34 INFO - PROCESS | 23439 | __metrics 06:04:34 ERROR - PROCESS | 23439 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:04:35 INFO - TEST-INFO | 23439: exit 0 06:04:35 INFO - Browser initialized. 06:04:35 INFO - Running cycle 1/1 for kraken test... 06:04:35 INFO - TEST-INFO | started process 23557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdsw5T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:47 INFO - PROCESS | 23557 | RSS: Main: 186535936 06:04:47 INFO - PROCESS | 23557 | 06:04:50 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:51 INFO - PROCESS | 23557 | RSS: Main: 191201280 06:04:51 INFO - PROCESS | 23557 | 06:04:54 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-dft) 06:04:55 INFO - PROCESS | 23557 | RSS: Main: 190455808 06:04:55 INFO - PROCESS | 23557 | 06:04:58 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-fft) 06:04:58 INFO - PROCESS | 23557 | RSS: Main: 187080704 06:04:58 INFO - PROCESS | 23557 | 06:05:00 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-oscillator) 06:05:01 INFO - PROCESS | 23557 | RSS: Main: 187195392 06:05:01 INFO - PROCESS | 23557 | 06:05:03 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:04 INFO - PROCESS | 23557 | RSS: Main: 187551744 06:05:04 INFO - PROCESS | 23557 | 06:05:07 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:08 INFO - PROCESS | 23557 | RSS: Main: 187682816 06:05:08 INFO - PROCESS | 23557 | 06:05:11 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:12 INFO - PROCESS | 23557 | RSS: Main: 184348672 06:05:12 INFO - PROCESS | 23557 | 06:05:15 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57399/tests/kraken/driver.html?testName=json-parse-financial) 06:05:16 INFO - PROCESS | 23557 | RSS: Main: 186441728 06:05:16 INFO - PROCESS | 23557 | 06:05:17 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:18 INFO - PROCESS | 23557 | RSS: Main: 187269120 06:05:18 INFO - PROCESS | 23557 | 06:05:20 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:20 INFO - PROCESS | 23557 | RSS: Main: 187334656 06:05:20 INFO - PROCESS | 23557 | 06:05:23 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:23 INFO - PROCESS | 23557 | RSS: Main: 187465728 06:05:23 INFO - PROCESS | 23557 | 06:05:26 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:27 INFO - PROCESS | 23557 | RSS: Main: 187371520 06:05:27 INFO - PROCESS | 23557 | 06:05:30 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:30 INFO - PROCESS | 23557 | RSS: Main: 186941440 06:05:30 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57399/tests/kraken/driver.html?testName=ai-astar) 06:05:32 INFO - PROCESS | 23557 | RSS: Main: 188338176 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | __start_tp_report 06:05:32 INFO - PROCESS | 23557 | _x_x_mozilla_page_load 06:05:32 INFO - PROCESS | 23557 | _x_x_mozilla_page_load_details 06:05:32 INFO - PROCESS | 23557 | |i|pagename|runs| 06:05:32 INFO - PROCESS | 23557 | |0;ai-astar;113;109;114;114;114;115;117;113;112;115 06:05:32 INFO - PROCESS | 23557 | |1;audio-beat-detection;157;131;157;191;133;166;161;136;192;133 06:05:32 INFO - PROCESS | 23557 | |2;audio-dft;163;168;171;162;164;161;167;166;164;164 06:05:32 INFO - PROCESS | 23557 | |3;audio-fft;80;77;76;165;78;77;76;76;165;78 06:05:32 INFO - PROCESS | 23557 | |4;audio-oscillator;88;88;154;87;87;87;136;89;87;135 06:05:32 INFO - PROCESS | 23557 | |5;imaging-gaussian-blur;117;117;118;118;118;118;120;119;118;118 06:05:32 INFO - PROCESS | 23557 | |6;imaging-darkroom;148;149;150;148;148;148;148;149;149;148 06:05:32 INFO - PROCESS | 23557 | |7;imaging-desaturate;96;95;95;95;100;96;97;97;95;96 06:05:32 INFO - PROCESS | 23557 | |8;json-parse-financial;69;70;72;66;65;64;67;66;65;66 06:05:32 INFO - PROCESS | 23557 | |9;json-stringify-tinderbox;64;65;64;65;64;65;65;63;65;65 06:05:32 INFO - PROCESS | 23557 | |10;stanford-crypto-aes;84;84;83;86;86;84;89;85;108;84 06:05:32 INFO - PROCESS | 23557 | |11;stanford-crypto-ccm;136;139;133;133;131;133;134;133;141;135 06:05:32 INFO - PROCESS | 23557 | |12;stanford-crypto-pbkdf2;173;176;173;171;165;166;171;173;166;165 06:05:32 INFO - PROCESS | 23557 | |13;stanford-crypto-sha256-iterative;68;71;67;69;69;67;68;68;67;68 06:05:32 INFO - PROCESS | 23557 | __end_tp_report 06:05:32 INFO - PROCESS | 23557 | __start_cc_report 06:05:32 INFO - PROCESS | 23557 | _x_x_mozilla_cycle_collect,988 06:05:32 INFO - PROCESS | 23557 | __end_cc_report 06:05:32 INFO - PROCESS | 23557 | __startTimestamp1465909532785__endTimestamp 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | ------- Summary: start ------- 06:05:32 INFO - PROCESS | 23557 | Number of tests: 14 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 06:05:32 INFO - PROCESS | 23557 | Values: 113.0 109.0 114.0 114.0 114.0 115.0 117.0 113.0 112.0 115.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:159.00 stddev:22.93 (14.4%) stddev-sans-first:24.31 06:05:32 INFO - PROCESS | 23557 | Values: 157.0 131.0 157.0 191.0 133.0 166.0 161.0 136.0 192.0 133.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.02 (1.8%) stddev-sans-first:3.11 06:05:32 INFO - PROCESS | 23557 | Values: 163.0 168.0 171.0 162.0 164.0 161.0 167.0 166.0 164.0 164.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:37.02 (48.1%) stddev-sans-first:38.88 06:05:32 INFO - PROCESS | 23557 | Values: 80.0 77.0 76.0 165.0 78.0 77.0 76.0 76.0 165.0 78.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:87.00 stddev:26.62 (30.6%) stddev-sans-first:27.61 06:05:32 INFO - PROCESS | 23557 | Values: 88.0 88.0 154.0 87.0 87.0 87.0 136.0 89.0 87.0 135.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 06:05:32 INFO - PROCESS | 23557 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 120.0 119.0 118.0 118.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:05:32 INFO - PROCESS | 23557 | Values: 148.0 149.0 150.0 148.0 148.0 148.0 148.0 149.0 149.0 148.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 06:05:32 INFO - PROCESS | 23557 | Values: 96.0 95.0 95.0 95.0 100.0 96.0 97.0 97.0 95.0 96.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.50 stddev:2.54 (3.8%) stddev-sans-first:2.59 06:05:32 INFO - PROCESS | 23557 | Values: 69.0 70.0 72.0 66.0 65.0 64.0 67.0 66.0 65.0 66.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:05:32 INFO - PROCESS | 23557 | Values: 64.0 65.0 64.0 65.0 64.0 65.0 65.0 63.0 65.0 65.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.50 stddev:7.47 (8.8%) stddev-sans-first:7.83 06:05:32 INFO - PROCESS | 23557 | Values: 84.0 84.0 83.0 86.0 86.0 84.0 89.0 85.0 108.0 84.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:134.50 stddev:3.08 (2.3%) stddev-sans-first:3.24 06:05:32 INFO - PROCESS | 23557 | Values: 136.0 139.0 133.0 133.0 131.0 133.0 134.0 133.0 141.0 135.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:172.00 stddev:4.04 (2.3%) stddev-sans-first:4.13 06:05:32 INFO - PROCESS | 23557 | Values: 173.0 176.0 173.0 171.0 165.0 166.0 171.0 173.0 166.0 165.0 06:05:32 INFO - PROCESS | 23557 | 06:05:32 INFO - PROCESS | 23557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 06:05:32 INFO - PROCESS | 23557 | Values: 68.0 71.0 67.0 69.0 69.0 67.0 68.0 68.0 67.0 68.0 06:05:32 INFO - PROCESS | 23557 | -------- Summary: end -------- 06:05:32 INFO - PROCESS | 23557 | 06:05:33 INFO - TEST-INFO | 23557: exit 0 06:05:33 INFO - TEST-OK | kraken | took 64070ms 06:05:33 INFO - SUITE-END | took 1180s 06:05:33 INFO - Completed test suite (00:19:40) 06:05:33 INFO - javascript benchmark 06:05:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6393.17403864436, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.9867450662746, 2696.5955106733995, 2700.986495067524, 2726.1548919834854, 2729.358600728828, 4840.467548569659, 4867.464578896323, 4910.901781964359, 4921.975390123049, 4932.087563800699, 4758.262469317253, 4871.464138944713, 4916.3117163597035, 4930.433000204977, 4979.751012449372, 4487.640988720903, 4537.591616754491, 4589.24277494213, 4627.097715945392, 4661.230896902007, 4470.217711900421, 4637.327587499811, 4651.302304654295, 4681.555252251031, 4693.624510039206, 4305.22505948929, 4505.504394516601, 4564.7717614119165, 4604.953950460503, 4606.585407313358, 4476.485204201526, 4486.955130448687, 4516.728996260202, 4523.864284071483, 4540.0, 4490.2142125127975, 4492.707973981681, 4505.752183629899, 4536.183486972343, 4552.248878934972, 4775.474697783241, 4827.8551643450755, 4847.927281090787, 4887.291342755316, 4902.583280421169, 5206.895862082775, 5220.556252718524, 5222.0, 5224.294720212799, 5224.346956630421, 5210.244514545369, 5248.291480650101, 5255.0278198533015, 5258.8685282867855, 5294.735263236861, 4716.764161791897, 4892.143874821928, 4958.107540642719, 4961.925571116436, 4969.552740253394, 5396.244525766396, 5409.134538473825, 5415.972920135374, 5422.8915421691345, 5428.077226871363, 4968.205087186105, 5180.507851754077, 5188.558972487305, 5223.451537588575, 5241.659292145999, 5236.6857988520815, 5254.500822421864, 5273.894522109613, 5303.973480132575, 5323.334583177103, 5005.099082165245, 5061.822836200715, 5126.8974620508125, 5170.069387510209, 5181.922271165936, 5147.356580427447, 5156.5616922562, 5157.871053223625, 5161.896762064737, 5200.323957885451, 4299.699021068558, 4346.826126954949, 4349.043210493686, 4383.276759334738, 4384.934225986613, 3847.2882516734494, 3879.86420475282, 3898.4542164097047, 3902.2195560887935, 3932.941005884914, 4610.124076425468, 4614.607758340579, 4617.538246175355, 4622.306654001926, 4655.092257009851, 5019.774110165052, 5240.371155461369, 5329.946700532945, 5344.35867695879, 5357.812476563379, 4574.81700731967, 4586.082783443325, 4592.928965293585, 4599.609033232213, 4640.721556706609, 4729.787159577827, 4736.976315118402, 4737.336772851803, 4742.691725037862, 4770.069836381872, 4732.361131247238, 4887.853364399074, 4950.900981980412, 4982.177940639826, 4992.251162325608, 5283.1546952487415, 5296.841094767163, 5299.258103865539, 5307.601929855199, 5350.03699334108, 4934.358533390637, 4952.059108769322, 4954.405471343318, 4970.080535101018, 4992.900141997213, 5030.170021946338, 5189.714565698923, 5199.4020687621405, 5243.475652434726, 5258.50044245796, 5322.0, 5327.866803329948, 5337.946620533745, 5339.252504649275, 5340.145576707708, 5178.352705911761, 5183.948160518346, 5184.429712731672, 5195.0, 5237.921431178459, 4899.559039686303, 4915.975420122876, 5066.341375621293, 5077.898442031064, 5139.383274006994, 4987.12725273083, 5013.097642424253, 5016.097102521435, 5051.87370315745, 5052.823151189691, 5239.44985776488, 5243.449437808975, 5245.475452454877, 5247.658902171499, 5270.8155214567305, 4804.543568361, 5001.799928002984, 5053.494650534917, 5082.491750824888, 5094.414142373675], "value": 4822.6115341907525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8998271703787, 581.8603535151564, 603.3785201242719, 607.9635221886687, 611.9841063834036, 34819.30361392774, 38758.61241387589, 38783.224335513274, 38825.61174388255, 38974.61025389749, 38494.23011539767, 38857.22285554295, 39021.60978390215, 39026.80486597563, 39054.8047259764, 7957.045154581444, 7980.640871160812, 8018.518888866657, 8028.879566806502, 8114.6754129834735, 7777.18339574345, 7797.844043119134, 7816.921830781676, 7830.138684744674, 7846.6469008894455, 7834.412419068564, 7908.960455197716, 7915.366770658362, 7939.325157361631, 7958.124606293303, 7789.454738168331, 7855.921440785576, 7878.4485086044, 7887.29014388702, 7895.24995125465, 7937.404694647925, 7989.760307190793, 7999.320057795095, 8020.67917283308, 8036.437449378546, 30101.0, 37443.0, 38057.42913856294, 38117.0, 38150.80924595387, 3014.623172103487, 3027.8334691591954, 3176.5552822604855, 3214.2928555717704, 3647.4893514907935, 28349.716502834915, 30779.84610076935, 31179.844100779577, 31300.217494562592, 31442.21394465134, 3482.6343233960574, 3516.944916525058, 3534.1164708822794, 3550.538430004083, 3550.8579656813695, 252571.0, 258731.0, 259488.0, 259495.0, 259665.9999999981, 33252.83373583117, 34134.658653413644, 34159.65840341614, 55818.441815581325, 57278.0, 34603.82698086544, 34677.0, 34882.825585871906, 34910.12724681903, 34943.475847862304, 13078.626744191914, 13155.0, 13219.867801322056, 13222.338883055809, 13227.404766785517, 10663.680089597325, 10689.732756680989, 10698.251122421356, 10705.30415523004, 10730.839037414446, 8071.919280807234, 8090.433669643068, 8120.106788253287, 8180.345572354197, 8247.092819789817, 3190.1546090286092, 3214.5821043264696, 3214.8231847248157, 3246.4318744219668, 3275.625171750462, 903.6340282185594, 907.3331101640289, 920.2040235196507, 945.177695405002, 966.5312323523086, 28060.85969570139, 28731.425371492453, 28828.42343153167, 29168.854155729085, 29225.269368265963, 899.2805755395657, 951.148721893915, 972.9708108756748, 1005.1054561440324, 1084.0189628386165, 14985.325660345092, 15228.46700365482, 15437.30532126057, 15710.9214453927, 15792.60518487047, 682789.0, 699016.0, 702444.0, 705783.0, 706707.0, 51581.22628160581, 52278.73860630749, 52426.47573524292, 52551.737241313545, 52775.47224527706, 1174.3775798826637, 1191.195942738648, 1200.0339726520235, 1216.951321947112, 1221.8900298972958, 27882.721172788013, 29052.709472905, 29593.85203073971, 30036.849815750782, 30420.84789576038, 44673.77663111794, 44739.77630111828, 44916.326255106855, 45014.77492612516, 45421.0, 363039.0, 364389.0, 364802.0, 366608.0, 367506.0, 25729.485410292065, 25949.610755839054, 26387.076452324076, 26706.59940100861, 26796.464070718088, 40798.184036319704, 41267.0, 41509.58490415057, 41587.7920610395, 41933.79033104815, 34096.31807363888, 34139.0, 34256.82871585626, 34751.826240868635, 34776.47835282524, 34449.794257200876, 35230.823845881634, 35433.0, 35540.0, 35691.821540893165, 31352.258564271826, 34645.13387165341, 34817.1295717599, 36156.81921590375, 37103.6289637111, 32739.836300818344, 34094.31811363808, 34530.65469345274, 34884.651153489154, 34941.650583493836, 26636.866815666574, 26699.466010680066, 26730.866345668146, 26776.732232677423, 26812.329691757863], "value": 16951.958671327036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.74901318090514, 365.9176685245819, 369.40156945747884, 379.47821745100487, 382.27558776119236, 15981.760273595906, 17402.738958915612, 17565.912170439162, 17848.910755446206, 18058.82617629853, 15903.761443578356, 16621.41825036124, 17635.470935871912, 17805.46583602491, 17851.64296714068, 4972.900541989158, 5137.3064636274, 5171.22431635254, 5178.585713142939, 5178.637495375326, 3741.8316175772156, 5089.694618322894, 5724.542036637059, 6105.0, 6109.5723299369065, 6038.033914573669, 6041.788537401192, 6054.0, 6077.665728384937, 6085.269767627891, 4860.416749989989, 5127.179651255799, 5152.433232344439, 5202.661826981234, 5225.268462415265, 4558.772061396917, 4826.420829500483, 4847.030593881203, 5184.274201611777, 5207.739613019334, 11980.880191198064, 12089.697757556132, 12150.513979440811, 13403.0, 20672.689909651366, 1916.7604049493814, 1921.1834970137775, 1969.5470041890446, 1980.633582787189, 2008.8895110768901, 8817.86773198396, 8956.238719708768, 8972.50651214183, 9035.864462033074, 9308.488033158173, 1640.4750479846455, 1642.868570514356, 1685.8904171228953, 1803.2877013579694, 1828.1133650179786, 68240.9999999995, 68528.31471685319, 69032.654836726, 69686.0, 70305.0, 10022.649207277711, 10061.887003729298, 10097.798044039226, 10156.441395723159, 10175.44035078063, 13707.657308567366, 13846.584602461942, 13850.16898986064, 13877.653058673613, 13900.51348202808, 7297.598632075181, 7342.816429589303, 7370.77887663371, 7463.2163622818825, 7472.476926615193, 6834.794956151323, 6857.519973601899, 6870.0, 6906.758263460855, 6945.131858517685, 4107.63031327176, 4154.937675934863, 4163.02168990287, 4181.581841815855, 4185.602367775056, 1663.717168081429, 1671.2562909505396, 1807.4216250799882, 1906.6282074995243, 1935.2549268531436, 741.2957690194229, 901.0223907060781, 922.5110691333604, 927.3230541704594, 928.7445952363154, 16775.580610484834, 16863.662726745395, 16919.154042297836, 17119.315227390765, 17199.57001074983, 826.9710560130487, 829.784256093408, 844.2950136635855, 857.4769390671685, 869.5347988825948, 9447.149756521945, 9575.281853860988, 9582.808343833223, 9641.903580964101, 9898.604055837686, 408390.0, 409819.0, 415153.0, 415261.0, 418890.0, 79018.6049069751, 80261.59869200733, 80966.0, 81945.18054819494, 82349.58825205835, 853.3216093205916, 889.6485888074175, 890.2966656341417, 890.857462805948, 895.5790778334173, 15258.237088145326, 15334.463293784664, 15411.152386618394, 15617.0, 15680.843191567938, 26630.600540992287, 27718.307042323297, 34371.828140859136, 35353.82323088368, 37024.62975370319, 44078.55921440873, 46036.0, 48991.75504122599, 50453.74773126111, 51184.0, 6711.563748356537, 7070.71717131309, 7077.539959902796, 7517.361024312994, 7591.278828511283, 11162.0, 11965.162438629213, 12003.699907502383, 12097.697557561132, 12353.876461235632, 9908.455034973145, 9980.101790838859, 10511.211659125443, 10656.094231990368, 10979.725506862393, 9182.95408522953, 9831.459269740233, 10076.748081298027, 10285.177185824967, 10404.11565016982, 9820.607175712892, 9972.650957216463, 10471.162307015267, 10541.0, 10694.251402401756, 7287.1984081752025, 7359.264073592598, 7468.10382754073, 7476.439267054884, 7507.962460187664, 8584.699535516227, 10327.690169294932, 10333.74165645865, 10389.740256493647, 10463.319884207502], "value": 8064.375233903758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.520667766282, 1406.303879579608, 1473.4400927647498, 1700.70237708401, 1702.9063401512913, 7045.365917067463, 7537.585432801194, 7611.657475413605, 8099.676012959482, 8114.715984940521, 7563.394928405728, 7894.17111203324, 7957.403194760387, 7960.2437768412055, 7962.283394494494, 2245.4610893385593, 2281.7490076091617, 2281.897314620846, 2294.105298933417, 2295.82781291403, 2248.235599896035, 2267.4104732769515, 2312.190733243368, 2317.1194945920524, 2319.988400058006, 2254.6618007298953, 2263.298377502971, 2268.6710426988075, 2271.82961277904, 2280.2133264023887, 2119.9258025969093, 2123.6814477828448, 2125.128697234127, 2134.157007981846, 2143.346279384787, 2162.0270878104916, 2173.576152650234, 2174.3150907464096, 2174.423777698911, 2177.8148857347146, 7826.804329891798, 7970.880436793453, 8025.555400027993, 8073.798155046112, 8079.111297757242, 4569.2003899317815, 4583.770811459413, 4621.792019359137, 4626.282926146453, 4666.463356713987, 2867.641544806899, 3003.819770813758, 3070.186400603842, 3072.6312842458824, 3074.738647214989, 978.4422878958997, 1015.9288849780519, 1018.2821111116644, 1035.1873779083458, 1039.438703100325, 10758.246922715412, 10772.569097236023, 10827.67516974492, 10837.891621083767, 10850.891491085067, 4221.197972385237, 4312.5903039211225, 4387.912241755147, 4412.558744125562, 4446.466424029137, 9152.95423522878, 9154.771130721785, 9179.58691858868, 9180.31147663928, 9190.0, 4669.276262179367, 4682.719036857799, 4692.812287508462, 4705.858824235278, 4724.574788269072, 3726.6459686329754, 4145.502539695256, 4156.896077598084, 4259.61663450291, 4301.612854843079, 3768.1144930941205, 3769.1896242308035, 3826.234753049401, 3839.865604703822, 3907.492026036597, 1193.3555879824798, 1224.908131890112, 1228.2323547782637, 1234.234774439835, 1237.5482948723652, 830.6469750356074, 847.5931552854664, 850.8085680721788, 857.5583574459158, 860.5525126933959, 5227.372715274191, 5387.838364849061, 5443.7822487100075, 5490.423505531941, 5519.944800551943, 406.13898535105767, 408.2243736899914, 415.6820032675006, 422.358015815958, 422.92175947449823, 3752.6434988676033, 3793.430985352219, 3815.08437974884, 3855.768653880776, 3893.7469064510715, 9198.586063627154, 9523.047695230422, 9715.514224288758, 9759.707208783748, 9855.162311203629, 9727.416355018722, 9731.756706082262, 9735.26985476078, 9764.0, 9765.951170244245, 7270.527415717961, 7390.150132734804, 7395.556266624019, 7432.739854105189, 7485.737999170112, 5206.8958620828125, 5230.686158830483, 5257.39539952895, 5417.864553386197, 5480.753366098455, 8872.64509419616, 9037.864432033657, 9141.862872056792, 9171.037041110587, 9184.12750788674, 8668.609912554077, 8934.955325223333, 9034.683786067457, 9124.0, 9287.164155226063, 6110.175126357884, 6363.3636636336, 6529.118568993125, 6627.768028118992, 6753.797386078426, 7661.6552255147535, 7663.578503182155, 7687.769366919001, 7688.923110768821, 7711.575863327571, 6579.506537009839, 6756.69594868242, 6813.3527314905, 6869.931300687129, 6892.276310987274, 6647.102641143384, 6669.233038200669, 6673.866522669617, 6728.831779205559, 6834.521583489108, 6350.555461117678, 6685.732570697118, 6703.966480167763, 6726.630035347907, 6770.255271920183, 4714.4106986626675, 4781.0, 4827.541383568555, 4857.854264372075, 4919.311296418433, 4530.252508336088, 4546.386237857847, 4582.725036497821, 4619.376384188226, 4743.786529606245], "value": 4141.795599143336, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5115512869152, 303.03030303030295, 304.5614315385844, 308.1602632825549, 311.36481577581736, 5082.822101226458, 5101.336826212591, 5137.383513978323, 5137.7944882204665, 5159.922601160985, 5001.349824522807, 5020.297158397827, 5052.974735126329, 5061.316722242496, 5090.287359769626, 3720.869769558066, 3845.4231865220163, 3985.8405663773415, 3988.78061706606, 3991.800409979504, 3966.424868394081, 3989.2021595680835, 3992.141689536749, 3994.0, 3997.4403583498333, 3973.5231772187235, 4005.919881602381, 4010.498687664042, 4011.3982902564703, 4028.45615841862, 3718.86983955563, 3931.2334094851517, 3944.7633142011573, 4000.6797756740207, 4029.717919745619, 3411.3177364527196, 3415.419378705601, 3418.9145271368166, 3419.5725534308212, 3445.414279572479, 4942.703437793743, 4947.381577302837, 5009.12340340439, 5011.398632164127, 5030.2897015014705, 4234.49675365244, 4456.685277843044, 4471.262241730111, 4480.843170489017, 4499.280115181556, 5300.522952934216, 5304.336957880265, 5308.9469105308835, 5309.442508536626, 5349.7057661828585, 3711.6845068169237, 3730.0674831292176, 3731.7574357666663, 3735.701143908508, 3741.7754934704003, 5409.323834520685, 5562.9443705563235, 5606.411326810708, 5645.830625081254, 5666.886662266773, 3770.377887648562, 3780.0, 3783.2244389900006, 3788.45067465216, 3789.2989796887664, 3839.9424008639894, 3845.442410850411, 3847.2690188864026, 3850.5956874528333, 3855.4216867469545, 4435.467743870691, 4437.134758722083, 4447.644188464915, 4457.866264012085, 4466.821327146943, 5232.189010703347, 5245.186996015624, 5336.359636843604, 5358.223057656618, 5387.9461205388225, 1309.8100775387516, 1325.5683861429634, 1325.7083441642824, 1335.9846516647417, 1337.2177276293282, 828.6850996621246, 837.6858677995751, 863.4215075899162, 867.2541614211773, 874.807542340684, 4656.464506581787, 4657.301404789241, 4683.548100088983, 4684.0, 4692.601128904013, 5354.250404943311, 5419.810306639249, 5421.484958928895, 5422.0, 5446.373667028263, 4552.430946131733, 4606.516315786861, 4664.230401983703, 4692.976535117371, 4693.9765301173275, 2896.116684411275, 2909.7090290971155, 2915.8250504969346, 2919.8102123361914, 2928.7217714317107, 5055.75019116497, 5074.2895994560795, 5094.0, 5097.362829646294, 5105.9489405106215, 5334.813281535127, 5536.307961504812, 5546.944530554642, 5552.916706249329, 5630.774769009276, 5060.544550990428, 5068.189089745697, 5082.517160869711, 5092.28707980883, 5117.7717347835505, 5407.188921661782, 5440.796477426648, 5459.426760190123, 5472.233887255867, 5474.0967740323995, 5049.545540901337, 5353.330833645794, 5375.892482150413, 5424.403315635198, 5453.481919217668, 5196.870078247923, 5223.817166399158, 5225.6603320784025, 5227.294315267391, 5256.526912577886, 3782.0, 3786.072412259014, 3789.1663833956486, 3810.276047551067, 3812.580616132279, 5276.841694749163, 5564.221009058654, 5568.387477377566, 5583.385827558884, 5643.633163844337, 5394.541463975449, 5420.457954204548, 5422.915416916553, 5426.561961080396, 5441.5102640762525, 5147.459516750687, 5348.117560602613, 5410.810621628224, 5415.619017150601, 5422.891542169214, 5214.904869977196, 5223.373195216598, 5248.816291429782, 5263.605229607718, 5284.9471505284455, 5164.302819119371, 5246.711430871186, 5427.0, 5446.509814116748, 5462.6995515247045, 5297.8145764898045, 5300.257963884982, 5307.389650190277, 5308.372355683961, 5331.600129990344], "value": 3988.5439406846085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8327918020495, 684.19265266985, 690.1786873620391, 710.3429327871718, 720.5640587444595, 12178.512859485621, 13112.47550097995, 13135.474581016771, 13151.27667978262, 13175.077744557897, 13484.393202305895, 14238.359273832677, 14275.428982840675, 14853.851461485381, 14875.0, 626.2422468812742, 797.8005498625358, 802.3621221129216, 804.6700852650414, 805.5972013992974, 791.4222617489236, 809.1099790230758, 810.8337790752911, 817.8364327134597, 820.3027426687298, 822.6791551294999, 824.8556502612049, 826.9503829770233, 827.954462504562, 828.2380210206594, 822.8560001999656, 824.04410883375, 824.2293455619016, 825.0717942314895, 826.0129145670926, 593.7803012885217, 599.2269971736455, 599.6192417814719, 600.213720026762, 602.3103546439303, 13512.986526010589, 13622.318884055856, 13642.727145457135, 13645.317734113254, 13707.794383084261, 12725.172863763826, 13055.281959492224, 13083.672908177277, 13105.0, 13189.736205275936, 10451.425171615558, 10493.790124197474, 10569.78860422795, 10598.947005264925, 10658.253922225447, 3236.4821628539557, 3305.173706573357, 3321.2029113012945, 3344.9331013379597, 3349.547811045502, 62417.37582624207, 62852.37147628511, 63788.043179352346, 64096.679516602584, 64282.35717642857, 9718.271129665303, 9868.457234852152, 9919.305648604528, 9985.700428987142, 10041.0, 17022.57443563921, 18087.18607662658, 18093.54766130831, 19137.425877223704, 19143.61712765737, 6768.796936091925, 6780.559263647847, 6842.623655698885, 7122.326253330463, 7173.6771845267085, 3513.4554144107706, 3541.769784963969, 3679.7424180307657, 3702.629737026276, 3767.434884767307, 2981.150372143972, 3024.803387779787, 3077.5229839374933, 3080.4609193391516, 3084.922876928095, 525.408914970658, 535.4484880573016, 545.18222666001, 546.8359492152339, 559.0803128853095, 455.92021396255524, 473.5312041079375, 537.7391964897022, 552.8203333916493, 557.7322885015134, 7499.662515186829, 7504.512206706547, 7665.884635563589, 7683.346915512244, 7732.7680169595005, 510.37224214216724, 514.452108504449, 522.9816956406584, 543.451164182078, 556.5130510803048, 3520.2431477232517, 3562.323158599858, 3586.1214002569536, 3670.1925576373155, 3716.646918542734, 91525.54237228772, 93289.5335523318, 93868.53065734764, 95222.52388738011, 96808.0, 82737.0, 84769.15230847737, 84829.15170848336, 85206.0, 86163.13836861677, 64231.35768642254, 71130.2886971134, 71285.64357178181, 73918.99999999892, 74821.87767183497, 6816.204147999257, 6846.246912839484, 7009.9649501752165, 7030.648467576499, 7146.3568278855155, 41698.791506042275, 43197.352039718804, 44035.37628548956, 44184.779076104416, 44376.0, 53261.7336913313, 62109.37890621036, 62255.0, 62773.68613156905, 63485.0, 9482.288828337765, 9734.41593504392, 9780.804383912424, 9830.311878168459, 10028.247881408777, 10807.405592692163, 10830.67507974762, 10885.129189664965, 11062.17033722458, 11265.549378024787, 9171.724848254564, 9316.580753866228, 9333.0, 9380.765480863032, 9414.2468602513, 10003.449810260505, 10084.747881303027, 10152.49237538135, 10317.48412579383, 10556.630517931835, 8805.339599530189, 8816.559172041501, 8887.600057997277, 8961.775955601162, 9104.681336153468, 8632.741017769476, 8804.339674524565, 9069.954650226706, 9306.225947019737, 9306.348555601044, 7697.8845317319165, 7715.421343399155, 7888.447808653339, 7897.328727058264, 8005.279524842792], "value": 6268.711432639916, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 114.0, 114.0, 115.0, 117.0, 113.0, 112.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 157.0, 191.0, 133.0, 166.0, 161.0, 136.0, 192.0, 133.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 171.0, 162.0, 164.0, 161.0, 167.0, 166.0, 164.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 76.0, 165.0, 78.0, 77.0, 76.0, 76.0, 165.0, 78.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 154.0, 87.0, 87.0, 87.0, 136.0, 89.0, 87.0, 135.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 120.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 100.0, 96.0, 97.0, 97.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 66.0, 65.0, 64.0, 67.0, 66.0, 65.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 63.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 86.0, 84.0, 89.0, 85.0, 108.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 133.0, 133.0, 131.0, 133.0, 134.0, 133.0, 141.0, 135.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 173.0, 171.0, 165.0, 166.0, 171.0, 173.0, 166.0, 165.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 69.0, 69.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 68.2, "unit": "score"}]}]} 06:05:34 INFO - Return code: 0 06:05:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:05:34 ERROR - # TBPL SUCCESS # 06:05:34 INFO - Running post-action listener: _resource_record_post_action 06:05:34 INFO - ##### 06:05:34 INFO - ##### Finished run-tests step (success) 06:05:34 INFO - ##### 06:05:34 INFO - Running post-run listener: _resource_record_post_run 06:05:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551948288; Read time: 16; Write time: 432960 06:05:34 INFO - TinderboxPrint: CPU usage
13.4% 06:05:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:05:34 INFO - TinderboxPrint: I/O write bytes / time
551,948,288 / 432,960 06:05:34 INFO - TinderboxPrint: CPU idle
8,272.8 (86.6%) 06:05:34 INFO - TinderboxPrint: CPU user
1,229.6 (12.9%) 06:05:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:05:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252530688; Read time: 0; Write time: 226424 06:05:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299417600; Read time: 16; Write time: 206536 06:05:34 INFO - Running post-run listener: _upload_blobber_files 06:05:34 INFO - Blob upload gear active. 06:05:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:05:34 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 06:05:34 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'] 06:05:34 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 06:05:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:05:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:35 INFO - (blobuploader) - INFO - Done attempting. 06:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:36 INFO - (blobuploader) - INFO - Done attempting. 06:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:40 INFO - (blobuploader) - INFO - Done attempting. 06:05:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:40 INFO - Return code: 0 06:05:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:05:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e6b26d5240ed1c2efba576af6fe564809f231b946353c82b6c1efa44764d6266c6c67a02cd0de9cb49454b0b96281d714b84e17cca0313c428eee7c505c2992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/105a7d62c7ed2b1ceab8c7c9563dd1f1994f8e9b8ba0a1c0451e069931de2856592e0728ba3652382b0e7fb901ea138f4ca8c92fef4862b3af082920d8192e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79bf9695a623e3cd34aceb9e562f91c044b4745ea056dc805a3e123883ca2f25281db51ca7652e07277ff4aa00369f4418f6be82d97cf296a2c19fbec844cc33"} 06:05:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:05:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:05:40 INFO - Contents: 06:05:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e6b26d5240ed1c2efba576af6fe564809f231b946353c82b6c1efa44764d6266c6c67a02cd0de9cb49454b0b96281d714b84e17cca0313c428eee7c505c2992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/105a7d62c7ed2b1ceab8c7c9563dd1f1994f8e9b8ba0a1c0451e069931de2856592e0728ba3652382b0e7fb901ea138f4ca8c92fef4862b3af082920d8192e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79bf9695a623e3cd34aceb9e562f91c044b4745ea056dc805a3e123883ca2f25281db51ca7652e07277ff4aa00369f4418f6be82d97cf296a2c19fbec844cc33"} 06:05:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:05:40 INFO - Copying logs to upload dir... 06:05:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:05:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.228168 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-14 06:05:39.810435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 06:05:39.813912) ========= 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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 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/4e6b26d5240ed1c2efba576af6fe564809f231b946353c82b6c1efa44764d6266c6c67a02cd0de9cb49454b0b96281d714b84e17cca0313c428eee7c505c2992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/105a7d62c7ed2b1ceab8c7c9563dd1f1994f8e9b8ba0a1c0451e069931de2856592e0728ba3652382b0e7fb901ea138f4ca8c92fef4862b3af082920d8192e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79bf9695a623e3cd34aceb9e562f91c044b4745ea056dc805a3e123883ca2f25281db51ca7652e07277ff4aa00369f4418f6be82d97cf296a2c19fbec844cc33"} build_url:https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/dUVGp_xyR46X51WcGzTaww/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/4e6b26d5240ed1c2efba576af6fe564809f231b946353c82b6c1efa44764d6266c6c67a02cd0de9cb49454b0b96281d714b84e17cca0313c428eee7c505c2992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/105a7d62c7ed2b1ceab8c7c9563dd1f1994f8e9b8ba0a1c0451e069931de2856592e0728ba3652382b0e7fb901ea138f4ca8c92fef4862b3af082920d8192e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79bf9695a623e3cd34aceb9e562f91c044b4745ea056dc805a3e123883ca2f25281db51ca7652e07277ff4aa00369f4418f6be82d97cf296a2c19fbec844cc33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 06:05:39.840054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 06:05:39.840373) ========= 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=0333a256a5e4f052382dd180000001b1-1465908299.692951-1259998966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 06:05:39.926322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 06:05:39.926640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 06:05:39.926932) ========= ========= Total master_lag: 0.17 =========