builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1466666019.07 results: success (0) buildid: 20160622232724 builduid: bb58608be59c42f79f3ea7d0d7a203d0 revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.069357) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.070053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.071042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.113413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.113936) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 00:13:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-06-23 00:13:41 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.261269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.261616) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.313531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:39.314431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 437fc937572dd344f58226d40ba9eccb4ffcaedb --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 437fc937572dd344f58226d40ba9eccb4ffcaedb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 00:13:41,219 truncating revision to first 12 chars 2016-06-23 00:13:41,219 Setting DEBUG logging. 2016-06-23 00:13:41,219 attempt 1/10 2016-06-23 00:13:41,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/437fc937572d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 00:13:41,634 unpacking tar archive at: fx-team-437fc937572d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:40.065442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:40.065772) ========= script_repo_revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:40.066252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:40.066556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 00:13:40.084172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 00:13:40.084486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:13:42 INFO - MultiFileLogger online at 20160623 00:13:42 in /builds/slave/test 00:13:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:13:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:13:42 INFO - {'append_to_log': False, 00:13:42 INFO - 'base_work_dir': '/builds/slave/test', 00:13:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:13:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:13:42 INFO - 'branch': 'Fx-Team-Non-PGO', 00:13:42 INFO - 'buildbot_json_path': 'buildprops.json', 00:13:42 INFO - 'config_files': ('talos/linux_config.py',), 00:13:42 INFO - 'default_actions': ('clobber', 00:13:42 INFO - 'read-buildbot-config', 00:13:42 INFO - 'download-and-extract', 00:13:42 INFO - 'populate-webroot', 00:13:42 INFO - 'create-virtualenv', 00:13:42 INFO - 'install', 00:13:42 INFO - 'run-tests'), 00:13:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:13:42 INFO - 'download_minidump_stackwalk': True, 00:13:42 INFO - 'download_symbols': 'ondemand', 00:13:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:13:42 INFO - 'tooltool.py': '/tools/tooltool.py', 00:13:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:13:42 INFO - '/tools/misc-python/virtualenv.py')}, 00:13:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:13:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:13:42 INFO - 'installer_path': 'installer.exe', 00:13:42 INFO - 'log_level': 'info', 00:13:42 INFO - 'log_name': 'talos', 00:13:42 INFO - 'log_to_console': True, 00:13:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:13:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:13:42 INFO - 'opt_config_files': (), 00:13:42 INFO - 'pip_index': False, 00:13:42 INFO - 'sps_profile': False, 00:13:42 INFO - 'sps_profile_interval': 0, 00:13:42 INFO - 'suite': 'dromaeojs', 00:13:42 INFO - 'system_bits': '32', 00:13:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:13:42 INFO - 'title': 'talos-linux64-ix-052', 00:13:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:13:42 INFO - 'use_talos_json': True, 00:13:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:13:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:13:42 INFO - 'work_dir': 'build'} 00:13:42 INFO - ##### 00:13:42 INFO - ##### Running clobber step. 00:13:42 INFO - ##### 00:13:42 INFO - Running pre-action listener: _resource_record_pre_action 00:13:42 INFO - Running main action method: clobber 00:13:42 INFO - rmtree: /builds/slave/test/build 00:13:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:13:43 INFO - Running post-action listener: _resource_record_post_action 00:13:43 INFO - ##### 00:13:43 INFO - ##### Finished clobber step (success) 00:13:43 INFO - ##### 00:13:43 INFO - ##### 00:13:43 INFO - ##### Running read-buildbot-config step. 00:13:43 INFO - ##### 00:13:43 INFO - Running pre-action listener: _resource_record_pre_action 00:13:43 INFO - Running main action method: read_buildbot_config 00:13:43 INFO - Using buildbot properties: 00:13:43 INFO - { 00:13:43 INFO - "project": "", 00:13:43 INFO - "product": "firefox", 00:13:43 INFO - "script_repo_revision": "production", 00:13:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:13:43 INFO - "repository": "", 00:13:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:13:43 INFO - "buildid": "20160622232724", 00:13:43 INFO - "pgo_build": "False", 00:13:43 INFO - "basedir": "/builds/slave/test", 00:13:43 INFO - "buildnumber": 3103, 00:13:43 INFO - "slavename": "talos-linux64-ix-052", 00:13:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:13:43 INFO - "platform": "ubuntu64_hw", 00:13:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:13:43 INFO - "branch": "fx-team", 00:13:43 INFO - "repo_path": "integration/fx-team", 00:13:43 INFO - "revision": "437fc937572dd344f58226d40ba9eccb4ffcaedb", 00:13:43 INFO - "stage_platform": "linux64", 00:13:43 INFO - "builduid": "bb58608be59c42f79f3ea7d0d7a203d0", 00:13:43 INFO - "slavebuilddir": "test" 00:13:43 INFO - } 00:13:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:13:43 INFO - Running post-action listener: _resource_record_post_action 00:13:43 INFO - ##### 00:13:43 INFO - ##### Finished read-buildbot-config step (success) 00:13:43 INFO - ##### 00:13:43 INFO - ##### 00:13:43 INFO - ##### Running download-and-extract step. 00:13:43 INFO - ##### 00:13:43 INFO - Running pre-action listener: _resource_record_pre_action 00:13:43 INFO - Running main action method: download_and_extract 00:13:43 INFO - mkdir: /builds/slave/test/build/tests 00:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:13:43 INFO - https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:13:45 INFO - Downloaded 1361 bytes. 00:13:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:13:45 INFO - Using the following test package requirements: 00:13:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:13:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:13:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:13:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'jsshell-linux-x86_64.zip'], 00:13:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:13:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:13:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:13:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:13:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:13:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:13:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:13:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:13:45 INFO - https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:13:50 INFO - Downloaded 22703251 bytes. 00:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:13:51 INFO - Return code: 0 00:13:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:13:51 INFO - https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:13:55 INFO - Downloaded 22703251 bytes. 00:13:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:13:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:13:57 INFO - Return code: 0 00:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:13:57 INFO - https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:13:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:13:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:13:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:13:58 INFO - Downloaded 14405384 bytes. 00:13:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:13:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:13:58 INFO - Return code: 0 00:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:13:58 INFO - https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:13:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:13:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:13:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:14:00 INFO - Downloaded 56262192 bytes. 00:14:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:14:00 INFO - mkdir: /builds/slave/test/properties 00:14:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:14:00 INFO - Writing to file /builds/slave/test/properties/build_url 00:14:00 INFO - Contents: 00:14:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:14:01 INFO - Running post-action listener: _resource_record_post_action 00:14:01 INFO - Running post-action listener: set_extra_try_arguments 00:14:01 INFO - ##### 00:14:01 INFO - ##### Finished download-and-extract step (success) 00:14:01 INFO - ##### 00:14:01 INFO - ##### 00:14:01 INFO - ##### Running populate-webroot step. 00:14:01 INFO - ##### 00:14:01 INFO - Running pre-action listener: _resource_record_pre_action 00:14:01 INFO - Running main action method: populate_webroot 00:14:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:14:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:14:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:14:01 INFO - '--tppagecycles', 00:14:01 INFO - '7'], 00:14:01 INFO - 'tests': ['tsvgm']}}, 00:14:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:14:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:14:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:14:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:14:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:14:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:14:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['damp', 'tps']}, 00:14:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'tests': ['damp', 'tps']}, 00:14:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['dromaeo_dom']}, 00:14:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:14:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['basic_compositor_video']}, 00:14:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:14:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'other-e10s': {'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['a11yr', 00:14:01 INFO - 'ts_paint', 00:14:01 INFO - 'tpaint', 00:14:01 INFO - 'sessionrestore', 00:14:01 INFO - 'sessionrestore_no_auto_restore', 00:14:01 INFO - 'tabpaint']}, 00:14:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['tsvgx', 00:14:01 INFO - 'tsvgr_opacity', 00:14:01 INFO - 'tart', 00:14:01 INFO - 'tscrollx', 00:14:01 INFO - 'cart']}, 00:14:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:14:01 INFO - 'tsvgr_opacity', 00:14:01 INFO - 'tart', 00:14:01 INFO - 'tscrollx', 00:14:01 INFO - 'cart']}, 00:14:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'talos_options': ['--disable-e10s'], 00:14:01 INFO - 'tests': ['tp5o']}, 00:14:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'tests': ['tp5o']}, 00:14:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'talos_options': ['--disable-e10s', 00:14:01 INFO - '--xperf_path', 00:14:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:14:01 INFO - 'tests': ['tp5n']}, 00:14:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:14:01 INFO - 'talos_options': ['--xperf_path', 00:14:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:14:01 INFO - 'tests': ['tp5n']}}, 00:14:01 INFO - 'talos.zip': {'path': '', 00:14:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:14:01 INFO - Running post-action listener: _resource_record_post_action 00:14:01 INFO - ##### 00:14:01 INFO - ##### Finished populate-webroot step (success) 00:14:01 INFO - ##### 00:14:01 INFO - ##### 00:14:01 INFO - ##### Running create-virtualenv step. 00:14:01 INFO - ##### 00:14:01 INFO - Running pre-action listener: _resource_record_pre_action 00:14:01 INFO - Running main action method: create_virtualenv 00:14:01 INFO - Creating virtualenv /builds/slave/test/build/venv 00:14:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:14:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:14:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:14:01 INFO - Using real prefix '/usr' 00:14:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:14:01 INFO - Installing distribute.............................................................................................................................................................................................done. 00:14:03 INFO - Installing pip.................done. 00:14:03 INFO - Return code: 0 00:14:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:14:03 INFO - Using env: {'DISPLAY': ':0', 00:14:03 INFO - 'HOME': '/home/cltbld', 00:14:03 INFO - 'LANG': 'en_US.UTF-8', 00:14:03 INFO - 'LANGUAGE': 'en_US:en', 00:14:03 INFO - 'LOGNAME': 'cltbld', 00:14:03 INFO - 'MAIL': '/var/mail/cltbld', 00:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:03 INFO - 'MOZ_NO_REMOTE': '1', 00:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:03 INFO - 'NO_EM_RESTART': '1', 00:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:03 INFO - 'PWD': '/builds/slave/test', 00:14:03 INFO - 'SHELL': '/bin/bash', 00:14:03 INFO - 'SHLVL': '1', 00:14:03 INFO - 'TERM': 'linux', 00:14:03 INFO - 'TMOUT': '86400', 00:14:03 INFO - 'USER': 'cltbld', 00:14:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:03 INFO - '_': '/tools/buildbot/bin/python'} 00:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:14:03 INFO - Cleaning up... 00:14:03 INFO - Return code: 0 00:14:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:14:03 INFO - Using env: {'DISPLAY': ':0', 00:14:03 INFO - 'HOME': '/home/cltbld', 00:14:03 INFO - 'LANG': 'en_US.UTF-8', 00:14:03 INFO - 'LANGUAGE': 'en_US:en', 00:14:03 INFO - 'LOGNAME': 'cltbld', 00:14:03 INFO - 'MAIL': '/var/mail/cltbld', 00:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:03 INFO - 'MOZ_NO_REMOTE': '1', 00:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:03 INFO - 'NO_EM_RESTART': '1', 00:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:03 INFO - 'PWD': '/builds/slave/test', 00:14:03 INFO - 'SHELL': '/bin/bash', 00:14:03 INFO - 'SHLVL': '1', 00:14:03 INFO - 'TERM': 'linux', 00:14:03 INFO - 'TMOUT': '86400', 00:14:03 INFO - 'USER': 'cltbld', 00:14:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:03 INFO - '_': '/tools/buildbot/bin/python'} 00:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:04 INFO - Downloading/unpacking psutil>=3.1.1 00:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:14:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:14:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:14:06 INFO - Installing collected packages: psutil 00:14:06 INFO - Running setup.py install for psutil 00:14:06 INFO - building 'psutil._psutil_linux' extension 00:14:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:14:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:14:06 INFO - building 'psutil._psutil_posix' extension 00:14:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:14:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:14:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:14:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:14:06 INFO - Successfully installed psutil 00:14:06 INFO - Cleaning up... 00:14:06 INFO - Return code: 0 00:14:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:06 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:14:06 INFO - Using env: {'DISPLAY': ':0', 00:14:06 INFO - 'HOME': '/home/cltbld', 00:14:06 INFO - 'LANG': 'en_US.UTF-8', 00:14:06 INFO - 'LANGUAGE': 'en_US:en', 00:14:06 INFO - 'LOGNAME': 'cltbld', 00:14:06 INFO - 'MAIL': '/var/mail/cltbld', 00:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:06 INFO - 'MOZ_NO_REMOTE': '1', 00:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:06 INFO - 'NO_EM_RESTART': '1', 00:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:06 INFO - 'PWD': '/builds/slave/test', 00:14:06 INFO - 'SHELL': '/bin/bash', 00:14:06 INFO - 'SHLVL': '1', 00:14:06 INFO - 'TERM': 'linux', 00:14:06 INFO - 'TMOUT': '86400', 00:14:06 INFO - 'USER': 'cltbld', 00:14:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:06 INFO - '_': '/tools/buildbot/bin/python'} 00:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:14:08 INFO - Installing collected packages: mozsystemmonitor 00:14:08 INFO - Running setup.py install for mozsystemmonitor 00:14:08 INFO - Successfully installed mozsystemmonitor 00:14:08 INFO - Cleaning up... 00:14:08 INFO - Return code: 0 00:14:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:14: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')]} 00:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14: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')]} 00:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:14:08 INFO - Using env: {'DISPLAY': ':0', 00:14:08 INFO - 'HOME': '/home/cltbld', 00:14:08 INFO - 'LANG': 'en_US.UTF-8', 00:14:08 INFO - 'LANGUAGE': 'en_US:en', 00:14:08 INFO - 'LOGNAME': 'cltbld', 00:14:08 INFO - 'MAIL': '/var/mail/cltbld', 00:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:08 INFO - 'MOZ_NO_REMOTE': '1', 00:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:08 INFO - 'NO_EM_RESTART': '1', 00:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:08 INFO - 'PWD': '/builds/slave/test', 00:14:08 INFO - 'SHELL': '/bin/bash', 00:14:08 INFO - 'SHLVL': '1', 00:14:08 INFO - 'TERM': 'linux', 00:14:08 INFO - 'TMOUT': '86400', 00:14:08 INFO - 'USER': 'cltbld', 00:14:08 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:08 INFO - '_': '/tools/buildbot/bin/python'} 00:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:09 INFO - Downloading/unpacking jsonschema==2.5.1 00:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:14:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:11 INFO - Downloading functools32-3.2.3-2.tar.gz 00:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:14:11 INFO - warning: no files found matching '*.txt' 00:14:11 INFO - no previously-included directories found matching 'build' 00:14:11 INFO - no previously-included directories found matching 'dist' 00:14:11 INFO - no previously-included directories found matching '.git*' 00:14:11 INFO - Installing collected packages: jsonschema, functools32 00:14:11 INFO - Running setup.py install for functools32 00:14:11 INFO - warning: no files found matching '*.txt' 00:14:11 INFO - no previously-included directories found matching 'build' 00:14:11 INFO - no previously-included directories found matching 'dist' 00:14:11 INFO - no previously-included directories found matching '.git*' 00:14:11 INFO - Successfully installed jsonschema functools32 00:14:11 INFO - Cleaning up... 00:14:11 INFO - Return code: 0 00:14:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:14:11 INFO - Using env: {'DISPLAY': ':0', 00:14:11 INFO - 'HOME': '/home/cltbld', 00:14:11 INFO - 'LANG': 'en_US.UTF-8', 00:14:11 INFO - 'LANGUAGE': 'en_US:en', 00:14:11 INFO - 'LOGNAME': 'cltbld', 00:14:11 INFO - 'MAIL': '/var/mail/cltbld', 00:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:11 INFO - 'MOZ_NO_REMOTE': '1', 00:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:11 INFO - 'NO_EM_RESTART': '1', 00:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:11 INFO - 'PWD': '/builds/slave/test', 00:14:11 INFO - 'SHELL': '/bin/bash', 00:14:11 INFO - 'SHLVL': '1', 00:14:11 INFO - 'TERM': 'linux', 00:14:11 INFO - 'TMOUT': '86400', 00:14:11 INFO - 'USER': 'cltbld', 00:14:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:11 INFO - '_': '/tools/buildbot/bin/python'} 00:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:11 INFO - Downloading/unpacking blobuploader==1.2.4 00:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:13 INFO - Downloading blobuploader-1.2.4.tar.gz 00:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:14:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:14 INFO - Downloading docopt-0.6.1.tar.gz 00:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 00:14:14 INFO - Running setup.py install for blobuploader 00:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:14:14 INFO - Running setup.py install for requests 00:14:14 INFO - Running setup.py install for docopt 00:14:14 INFO - Successfully installed blobuploader requests docopt 00:14:14 INFO - Cleaning up... 00:14:14 INFO - Return code: 0 00:14:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:14 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:14:14 INFO - Using env: {'DISPLAY': ':0', 00:14:14 INFO - 'HOME': '/home/cltbld', 00:14:14 INFO - 'LANG': 'en_US.UTF-8', 00:14:14 INFO - 'LANGUAGE': 'en_US:en', 00:14:14 INFO - 'LOGNAME': 'cltbld', 00:14:14 INFO - 'MAIL': '/var/mail/cltbld', 00:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:14 INFO - 'MOZ_NO_REMOTE': '1', 00:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:14 INFO - 'NO_EM_RESTART': '1', 00:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:14 INFO - 'PWD': '/builds/slave/test', 00:14:14 INFO - 'SHELL': '/bin/bash', 00:14:14 INFO - 'SHLVL': '1', 00:14:14 INFO - 'TERM': 'linux', 00:14:14 INFO - 'TMOUT': '86400', 00:14:14 INFO - 'USER': 'cltbld', 00:14:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:14 INFO - '_': '/tools/buildbot/bin/python'} 00:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:14:15 INFO - Running setup.py (path:/tmp/pip-UgAi65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:14:15 INFO - Running setup.py (path:/tmp/pip-C9PPpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:14:15 INFO - Running setup.py (path:/tmp/pip-CS119C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:14:15 INFO - Running setup.py (path:/tmp/pip-IOI30H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:14:15 INFO - Running setup.py (path:/tmp/pip-cd2v5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:14:15 INFO - Running setup.py (path:/tmp/pip-ZkSgVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:14:15 INFO - Running setup.py (path:/tmp/pip-mzzh0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:14:15 INFO - Running setup.py (path:/tmp/pip-ys5VV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:14:15 INFO - Running setup.py (path:/tmp/pip-NSKr_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:14:15 INFO - Running setup.py (path:/tmp/pip-_YOo_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:14:15 INFO - Running setup.py (path:/tmp/pip-ylKXVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:14:15 INFO - Running setup.py (path:/tmp/pip-MRVVFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:14:16 INFO - Running setup.py (path:/tmp/pip-us6wNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:14:16 INFO - Running setup.py (path:/tmp/pip-VRnitx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:16 INFO - Running setup.py (path:/tmp/pip-eOynLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:14:16 INFO - Running setup.py (path:/tmp/pip-iMpE55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:14:16 INFO - Running setup.py (path:/tmp/pip-3LhiRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:14:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:14:16 INFO - Running setup.py install for manifestparser 00:14:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:14:16 INFO - Running setup.py install for mozcrash 00:14:16 INFO - Running setup.py install for mozdebug 00:14:16 INFO - Running setup.py install for mozdevice 00:14:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:14:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:14:16 INFO - Running setup.py install for mozfile 00:14:16 INFO - Running setup.py install for mozhttpd 00:14:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:14:16 INFO - Running setup.py install for mozinfo 00:14:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for mozInstall 00:14:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for mozleak 00:14:17 INFO - Running setup.py install for mozlog 00:14:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for moznetwork 00:14:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for mozprocess 00:14:17 INFO - Running setup.py install for mozprofile 00:14:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for mozrunner 00:14:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:14:17 INFO - Running setup.py install for mozscreenshot 00:14:17 INFO - Running setup.py install for moztest 00:14:18 INFO - Running setup.py install for mozversion 00:14:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:14:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:14:18 INFO - Cleaning up... 00:14:18 INFO - Return code: 0 00:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:18 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:14:18 INFO - Using env: {'DISPLAY': ':0', 00:14:18 INFO - 'HOME': '/home/cltbld', 00:14:18 INFO - 'LANG': 'en_US.UTF-8', 00:14:18 INFO - 'LANGUAGE': 'en_US:en', 00:14:18 INFO - 'LOGNAME': 'cltbld', 00:14:18 INFO - 'MAIL': '/var/mail/cltbld', 00:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:18 INFO - 'MOZ_NO_REMOTE': '1', 00:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:18 INFO - 'NO_EM_RESTART': '1', 00:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:18 INFO - 'PWD': '/builds/slave/test', 00:14:18 INFO - 'SHELL': '/bin/bash', 00:14:18 INFO - 'SHLVL': '1', 00:14:18 INFO - 'TERM': 'linux', 00:14:18 INFO - 'TMOUT': '86400', 00:14:18 INFO - 'USER': 'cltbld', 00:14:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:18 INFO - '_': '/tools/buildbot/bin/python'} 00:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:14:18 INFO - Running setup.py (path:/tmp/pip-1aHNpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:14:18 INFO - Running setup.py (path:/tmp/pip-OriVf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:14:18 INFO - Running setup.py (path:/tmp/pip-8fpsbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:14:18 INFO - Running setup.py (path:/tmp/pip-R2dNNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:14:18 INFO - Running setup.py (path:/tmp/pip-5468jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:14:18 INFO - Running setup.py (path:/tmp/pip-vey9yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:14:18 INFO - Running setup.py (path:/tmp/pip-aPrAB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:14:18 INFO - Running setup.py (path:/tmp/pip-5d35aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:14:18 INFO - Running setup.py (path:/tmp/pip-T5lJ8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:14:19 INFO - Running setup.py (path:/tmp/pip-qEM5Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:14:19 INFO - Running setup.py (path:/tmp/pip-hM9dUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:14:19 INFO - Running setup.py (path:/tmp/pip-BoVZmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:14:19 INFO - Running setup.py (path:/tmp/pip-K2fQAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:14:19 INFO - Running setup.py (path:/tmp/pip-PuGG9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:19 INFO - Running setup.py (path:/tmp/pip-_g5slD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:14:19 INFO - Running setup.py (path:/tmp/pip-eVE2Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:14:19 INFO - Running setup.py (path:/tmp/pip-iPaoXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:14:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:21 INFO - Downloading blessings-1.6.tar.gz 00:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:14:21 INFO - Installing collected packages: blessings 00:14:21 INFO - Running setup.py install for blessings 00:14:21 INFO - Successfully installed blessings 00:14:21 INFO - Cleaning up... 00:14:21 INFO - Return code: 0 00:14:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:14:22 INFO - Reading from file tmpfile_stdout 00:14:22 INFO - Current package versions: 00:14:22 INFO - argparse == 1.2.1 00:14:22 INFO - blessings == 1.6 00:14:22 INFO - blobuploader == 1.2.4 00:14:22 INFO - docopt == 0.6.1 00:14:22 INFO - functools32 == 3.2.3-2 00:14:22 INFO - jsonschema == 2.5.1 00:14:22 INFO - manifestparser == 1.1 00:14:22 INFO - mozInstall == 1.12 00:14:22 INFO - mozcrash == 0.17 00:14:22 INFO - mozdebug == 0.1 00:14:22 INFO - mozdevice == 0.48 00:14:22 INFO - mozfile == 1.2 00:14:22 INFO - mozhttpd == 0.7 00:14:22 INFO - mozinfo == 0.9 00:14:22 INFO - mozleak == 0.1 00:14:22 INFO - mozlog == 3.2 00:14:22 INFO - moznetwork == 0.27 00:14:22 INFO - mozprocess == 0.22 00:14:22 INFO - mozprofile == 0.28 00:14:22 INFO - mozrunner == 6.11 00:14:22 INFO - mozscreenshot == 0.1 00:14:22 INFO - mozsystemmonitor == 0.3 00:14:22 INFO - moztest == 0.7 00:14:22 INFO - mozversion == 1.4 00:14:22 INFO - psutil == 3.1.1 00:14:22 INFO - requests == 1.2.3 00:14:22 INFO - wsgiref == 0.1.2 00:14:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:14:22 INFO - Using env: {'DISPLAY': ':0', 00:14:22 INFO - 'HOME': '/home/cltbld', 00:14:22 INFO - 'LANG': 'en_US.UTF-8', 00:14:22 INFO - 'LANGUAGE': 'en_US:en', 00:14:22 INFO - 'LOGNAME': 'cltbld', 00:14:22 INFO - 'MAIL': '/var/mail/cltbld', 00:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:22 INFO - 'MOZ_NO_REMOTE': '1', 00:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:22 INFO - 'NO_EM_RESTART': '1', 00:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:22 INFO - 'PWD': '/builds/slave/test', 00:14:22 INFO - 'SHELL': '/bin/bash', 00:14:22 INFO - 'SHLVL': '1', 00:14:22 INFO - 'TERM': 'linux', 00:14:22 INFO - 'TMOUT': '86400', 00:14:22 INFO - 'USER': 'cltbld', 00:14:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:22 INFO - '_': '/tools/buildbot/bin/python'} 00:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:14:22 INFO - Cleaning up... 00:14:22 INFO - Return code: 0 00:14:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:14:22 INFO - Using env: {'DISPLAY': ':0', 00:14:22 INFO - 'HOME': '/home/cltbld', 00:14:22 INFO - 'LANG': 'en_US.UTF-8', 00:14:22 INFO - 'LANGUAGE': 'en_US:en', 00:14:22 INFO - 'LOGNAME': 'cltbld', 00:14:22 INFO - 'MAIL': '/var/mail/cltbld', 00:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:22 INFO - 'MOZ_NO_REMOTE': '1', 00:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:22 INFO - 'NO_EM_RESTART': '1', 00:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:22 INFO - 'PWD': '/builds/slave/test', 00:14:22 INFO - 'SHELL': '/bin/bash', 00:14:22 INFO - 'SHLVL': '1', 00:14:22 INFO - 'TERM': 'linux', 00:14:22 INFO - 'TMOUT': '86400', 00:14:22 INFO - 'USER': 'cltbld', 00:14:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:22 INFO - '_': '/tools/buildbot/bin/python'} 00:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:14:22 INFO - Cleaning up... 00:14:22 INFO - Return code: 0 00:14:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:14:22 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 0x7fa675e01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe59350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:14:22 INFO - Using env: {'DISPLAY': ':0', 00:14:22 INFO - 'HOME': '/home/cltbld', 00:14:22 INFO - 'LANG': 'en_US.UTF-8', 00:14:22 INFO - 'LANGUAGE': 'en_US:en', 00:14:22 INFO - 'LOGNAME': 'cltbld', 00:14:22 INFO - 'MAIL': '/var/mail/cltbld', 00:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:22 INFO - 'MOZ_NO_REMOTE': '1', 00:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:22 INFO - 'NO_EM_RESTART': '1', 00:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:22 INFO - 'PWD': '/builds/slave/test', 00:14:22 INFO - 'SHELL': '/bin/bash', 00:14:22 INFO - 'SHLVL': '1', 00:14:22 INFO - 'TERM': 'linux', 00:14:22 INFO - 'TMOUT': '86400', 00:14:22 INFO - 'USER': 'cltbld', 00:14:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:22 INFO - '_': '/tools/buildbot/bin/python'} 00:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:14:22 INFO - Downloading/unpacking flake8 00:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:14:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:14:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:14:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14: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 00:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:14:25 INFO - no previously-included directories found matching 'docs/_build' 00:14:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:14:25 INFO - Running setup.py install for pep8 00:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:14:25 INFO - no previously-included directories found matching 'docs/_build' 00:14:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:14:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:14:25 INFO - Cleaning up... 00:14:25 INFO - Return code: 0 00:14:25 INFO - Running post-action listener: _resource_record_post_action 00:14:25 INFO - Running post-action listener: _start_resource_monitoring 00:14:25 INFO - Starting resource monitoring. 00:14:25 INFO - ##### 00:14:25 INFO - ##### Finished create-virtualenv step (success) 00:14:25 INFO - ##### 00:14:25 INFO - ##### 00:14:25 INFO - ##### Running install step. 00:14:25 INFO - ##### 00:14:25 INFO - Running pre-action listener: _resource_record_pre_action 00:14:25 INFO - Running main action method: install 00:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:14:25 INFO - Reading from file tmpfile_stdout 00:14:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:14:25 INFO - Reading from file tmpfile_stdout 00:14:25 INFO - Output received: 00:14:25 INFO - Usage: mozinstall [options] installer 00:14:25 INFO - Options: 00:14:25 INFO - -h, --help show this help message and exit 00:14:25 INFO - -d DEST, --destination=DEST 00:14:25 INFO - Directory to install application into. [default: 00:14:25 INFO - "/builds/slave/test"] 00:14:25 INFO - --app=APP Application being installed. [default: firefox] 00:14:25 INFO - mkdir: /builds/slave/test/build/application 00:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:14:42 INFO - Reading from file tmpfile_stdout 00:14:42 INFO - Output received: 00:14:42 INFO - /builds/slave/test/build/application/firefox/firefox 00:14:42 INFO - Running post-action listener: _resource_record_post_action 00:14:42 INFO - ##### 00:14:42 INFO - ##### Finished install step (success) 00:14:42 INFO - ##### 00:14:42 INFO - ##### 00:14:42 INFO - ##### Running run-tests step. 00:14:42 INFO - ##### 00:14:42 INFO - Running pre-action listener: _resource_record_pre_action 00:14:42 INFO - Running main action method: run_tests 00:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:14:42 INFO - Python 2.7.3 00:14:42 INFO - Return code: 0 00:14:42 INFO - grabbing minidump binary from tooltool 00:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:14:42 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 0xee81c0>, '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 0xee90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:14:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:14:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:14:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:14:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:14:42 INFO - Return code: 0 00:14:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:14:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:14:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:14:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:14:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:14:43 INFO - Return code: 0 00:14:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:14:43 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:14:43 INFO - Using env: {'DISPLAY': ':0', 00:14:43 INFO - 'HOME': '/home/cltbld', 00:14:43 INFO - 'LANG': 'en_US.UTF-8', 00:14:43 INFO - 'LANGUAGE': 'en_US:en', 00:14:43 INFO - 'LOGNAME': 'cltbld', 00:14:43 INFO - 'MAIL': '/var/mail/cltbld', 00:14:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:14:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:14:43 INFO - 'MOZ_NO_REMOTE': '1', 00:14:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:14:43 INFO - 'NO_EM_RESTART': '1', 00:14:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:14:43 INFO - 'PWD': '/builds/slave/test', 00:14:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:14:43 INFO - 'SHELL': '/bin/bash', 00:14:43 INFO - 'SHLVL': '1', 00:14:43 INFO - 'TERM': 'linux', 00:14:43 INFO - 'TMOUT': '86400', 00:14:43 INFO - 'USER': 'cltbld', 00:14:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401', 00:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:14:43 INFO - '_': '/tools/buildbot/bin/python'} 00:14:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:14:43 INFO - mozversion application_buildid: 20160622232724 00:14:43 INFO - mozversion application_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 00:14:43 INFO - mozversion application_display_name: Nightly 00:14:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:14:43 INFO - mozversion application_name: Firefox 00:14:43 INFO - mozversion application_remotingname: firefox 00:14:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:14:43 INFO - mozversion application_vendor: Mozilla 00:14:43 INFO - mozversion application_version: 50.0a1 00:14:43 INFO - mozversion platform_buildid: 20160622232724 00:14:43 INFO - mozversion platform_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 00:14:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:14:43 INFO - mozversion platform_version: 50.0a1 00:14:43 INFO - using testdate: 1466666083 00:14:43 INFO - actual date: 1466666083 00:14:43 INFO - starting webserver on 'localhost:50471' 00:14:43 INFO - SUITE-START | Running 2 tests 00:14:43 INFO - TEST-START | dromaeo_css 00:14:43 INFO - operating with platform_type : linux_ 00:14:43 INFO - Initialising browser for dromaeo_css test... 00:14:43 INFO - TEST-INFO | started process 28364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6aSPov/profile http://localhost:50471/getInfo.html) 00:14:47 INFO - PROCESS | 28364 | __metrics Screen width/height:1600/1200 00:14:47 INFO - PROCESS | 28364 | colorDepth:24 00:14:47 INFO - PROCESS | 28364 | Browser inner width/height: 1024/697 00:14:47 INFO - PROCESS | 28364 | __metrics 00:14:48 INFO - PROCESS | 28364 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:14:49 INFO - TEST-INFO | 28364: exit 0 00:14:49 INFO - Browser initialized. 00:14:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:14:49 INFO - TEST-INFO | started process 28443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6aSPov/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:01 INFO - PROCESS | 28443 | RSS: Main: 174813184 00:15:01 INFO - PROCESS | 28443 | 00:15:51 INFO - PROCESS | 28443 | 1466666151972 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] 00:18:05 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50471/tests/dromaeo/cssquery-ext.html) 00:18:06 INFO - PROCESS | 28443 | RSS: Main: 271253504 00:18:06 INFO - PROCESS | 28443 | 00:21:08 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-ext.html (next: http://localhost:50471/tests/dromaeo/cssquery-jquery.html) 00:21:09 INFO - PROCESS | 28443 | RSS: Main: 255107072 00:21:09 INFO - PROCESS | 28443 | 00:24:11 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50471/tests/dromaeo/cssquery-mootools.html) 00:24:12 INFO - PROCESS | 28443 | RSS: Main: 260780032 00:24:12 INFO - PROCESS | 28443 | 00:27:14 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50471/tests/dromaeo/cssquery-prototype.html) 00:27:14 INFO - PROCESS | 28443 | RSS: Main: 258244608 00:27:14 INFO - PROCESS | 28443 | 00:30:17 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50471/tests/dromaeo/cssquery-yui.html) 00:30:18 INFO - PROCESS | 28443 | RSS: Main: 227401728 00:30:18 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | Cycle 1(1): loaded http://localhost:50471/tests/dromaeo/cssquery-yui.html (next: http://localhost:50471/tests/dromaeo/cssquery-dojo.html) 00:33:21 INFO - PROCESS | 28443 | RSS: Main: 289284096 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | __start_tp_report 00:33:21 INFO - PROCESS | 28443 | _x_x_mozilla_page_load 00:33:21 INFO - PROCESS | 28443 | _x_x_mozilla_page_load_details 00:33:21 INFO - PROCESS | 28443 | |i|pagename|runs| 00:33:21 INFO - PROCESS | 28443 | |0;dojo.html;2619.3189770659624;2621.462600166966;2643.2863126955717;2653.0979466981235;2660.76053155216;4729.456112547058;4753.548412900777;4815.422149342084;4848.999999999995;4858.07696537658;4827.951720482794;4834.468208497063;4838.443578988417;4855.975720121394;4918.803247870081;4472.910541789162;4481.170983368071;4511.436070491189;4512.706674066175;4514.932276015862;4469.620082293009;4528.366028755977;4540.954590454103;4570.908581828378;4625.537446255365;4513;4581.9312710309205;4600.516945720701;4600.953990460102;4602.309653551961;4384.539623339567;4418.911621767579;4440.02319489715;4443.4445694288215;4524.977375113136;4443.666724995606;4443.688941774045;4456.2647163218035;4491.887702807423;4503.482099558527;4995.125852975715;4998.250262460624;4999.999999999978;5009.649324547283;5014.774335154927;5111.693298402108;5189.922151167735;5267.236250743659;5267.86830329241;5344.385395679507;5294.735263236861;5307.442718514539;5340.599455040888;5341;5343.305370301836;4989.999999999964;4998.425181104147;5001.42483614389;5003.874903127378;5004.924926126111;5274.024305503417;5310.575153987672;5467.4532546745;5495.0383682855345;5511.53151982086;5232.2413250078525;5235.345581802275;5277.8416647500635;5286.022085914041;5288.497592728685;5308.071087559739;5313.973430132902;5324.547413469899;5328.280682107943;5376.1398176291605;5067.1639179535705;5094.439611642716;5146.562542183956;5159.664621799571;5175.430702622709;5165;5170.121079416508;5178.352705911761;5182.1190397631735;5238.764255608507;4272.91454170921;4432.534583868712;4441.511433742286;4448;4485.865424037219;3757.1358587525024;3824.694024478035;3853.190829925747;3868.941965870514;3907.1404291055924;4439.42287502629;4456.264716321771;4458.554144585515;4503.504614492469;4503.617192538671;5154.768035438415;5228.764705588258;5237.319148510745;5244.606654500928;5292.391374991848;4382.978085109554;4399.670024748157;4435.090806384684;4456.331550267421;4464.464264288241;4682.993156471375;4709.199436095803;4711.623070154448;4717.245240761462;4764.928526072112;4789.904201915872;4892.706437613754;4913.336699545515;4917.557419832232;4966.826161084273;5187.974060129826;5252.133397989289;5262.500062494057;5296.682199068068;5319.9468005321;4921.876953076202;4927.088488629615;4934.5312195341385;4963.10664080469;4972.179590367549;5176.352955880515;5183.067047931258;5186.8962620748125;5189.247559103834;5191.32512773337;5130.256112863689;5236.240745092016;5295.470452954828;5302.3637163540625;5365.061114305059;5152;5153.510416510426;5155.2782610433815;5156.1750119980625;5183.377994640668;5144.125498665161;5154.252633368065;5164.406093299319;5167.61242906791;5208.5312321891215;4928.704277743347;4952.232403977389;4981.476944920876;5029.823956161663;5070.087384270867;5128.205128205134;5150.948490515047;5154.123798954111;5162.432132465351;5164.04465173944;4952.653314267966;5027.698338099725;5034.697918124924;5040.899182016413;5082 00:33:21 INFO - PROCESS | 28443 | |1;ext.html;542.7408412483038;574.8907707535568;587.6063037764698;588.1706793421274;592.2537602620698;26495;37731;38347.61652383475;38368.80815595918;38426.23147537054;40004;40531.594684053154;40663.39004914929;40671;40740.38889416661;7521.135069466999;7771.222877712212;7916.722914697987;10138.6958391248;10409.895901040969;10059.34614250075;10162.441065741417;10167.796644067113;10176.79646407075;10184.694459166238;10249.333793303449;10287.045461362355;10301.27891047627;10304.587816487368;10305.690829275134;7492.625368731569;10145.289829711923;10397.584096636125;10400;10687.30532515384;10180.592776289013;10228.693139205836;10245;10247.231457640706;10255.794884102275;37851.242975140616;38194;38254;38257.17428257152;38265.617343826765;3135.984320078408;3182.7294679952233;3195.392875353675;3201.6478187399366;3484.285721427101;29395.41209175826;29468.557971630442;29659.94115802223;29802.70197298021;29805.552916706267;3513.7189024878203;3545.4859045438525;3571.4107172316794;3575.410057340536;3622.8188590570367;388553;392277;393147;394581;394831;55313.72343138258;55706.72146639241;55899.720501397234;55921.16118258229;56022.71988640112;32833.50749738756;32992.340153196805;33622.663773362445;35191.4721279181;35196.76811311592;14038.929805350908;14970.326335314938;15087.24563771807;15132.319045642973;15269.541913742605;11143.16426268017;11322.830157547643;11416.486258118404;11520.596779112691;11654.30074195551;18536.960934297218;18549.258029678662;18580.163892624594;18608.34870779516;18663;6624.436922861514;6730.697118629673;6830.7609233676585;6851.3491218334175;6853;796.3708670150633;846.2679781988536;908.6456282050005;951.6526467839327;1029.7219750667277;27827.304317392227;27960;28291.575626365622;28689.13932582026;28794.424111517652;960.7213907966751;983.1151963233148;984.921206303494;1009.5305682857506;1071.23406764164;14866;15003.924980375028;15029.774553381709;15384.846151538566;15401.383944642088;380341;382483;383615;384513;385871;48968.265476017885;49462;49587;49646.50353496491;49717.75141124344;1078.5470102556944;1163.9301641901682;1198.113396086907;1205.9336736479577;1206.3003457994341;26955.86522067377;28431.431371372044;28553.14340569786;28894.133176004754;29108.27229319284;40875.7956210217;41663.16673666449;41737.16525669409;41809.79095104505;41859.7907010463;235498;235766;235772;236424;236678;24891.377715557257;25897;26041;27339.179824605293;27363.17910462689;42469.575304247795;42984;43613.127737445706;43695.12609747851;43848.34227486654;35123.29753404867;36649.81675091608;36830;36944.63055369519;37124.81437592795;35888.4616730744;36077.0980725484;36089.81955090313;36123.458148127276;36422.4536631956;35250.59367579053;36267;36287.81856090703;36466.63533364632;36569;31804.363912721154;32794.18014549655;33171.170720732174;33473.83263083669;33517.83241083779;25282;25438.49123017492;25781.3554661135;25939.22182334533;26211 00:33:21 INFO - PROCESS | 28443 | |2;jquery.html;353.53157066886365;370.3833117858765;373.97569158004734;376.2662807525326;391.38747859599727;16021.679566408664;16052.277647505862;17527.298908043664;17547;17570.560735981606;15998.520044398687;16342.918285408587;17079.316827326893;17156.31374745012;17233.396831110913;5015.523525265103;5169.224616307565;5172.27588137661;5209.1404918188455;5216.582673386139;4998.025385049898;5093.185090385539;5119.539241468267;5147.613928955325;5161.4322424533275;5198.064348417283;5232.947670523284;5245.868853278679;5249.370075590915;5249.842504724865;4968.776405061781;5136.280920671109;5164.431912489623;5189.974050129763;5191.974040129794;4487.6634252431195;4504.8873778155485;4515.029268707243;4520.254158063915;4531.116432295704;19554.120064597126;20144.09351579168;20241.493962650904;20307.289244876505;20983.790162098336;1961.990190049055;1979.5743915058188;2038.8776673399643;2521.735217802123;2556.412025234188;12703.618891433272;13234.139780914305;13321.40053697586;13749.037567370287;13854.307284635828;1679.82361852005;1746.1531157388783;1776.7956684981264;1781.3141940352928;1858.5539470527112;37391.813040934896;55912.44087559113;61429.69285153546;65260;66337.66831165813;9815.067568580973;9999.55002024896;10075.445850478147;10152.289339746294;10164.085232328978;12263.448144833505;12344.938275308567;13164.40760165795;13801.585952421443;13814.792778108336;7025.92974070263;7042.718291268292;7186.7125314986815;7310.744123955636;7382.446316526175;7189.3170148836825;7229.674664640103;7311.853762924712;7372.889406658905;7373.668184931691;5931.466168044896;6156.8768624627255;6162.291336496271;6207.6275423473835;6289.937100628935;1775.9822401776075;1787.428023032643;1787.8480329171905;1801.738747881576;1835.431016384925;851.6295411496019;870.7039606533682;892.3530440430766;896.6413434626202;938.4181807279394;16608.335666573443;16973.915130424517;17529.474115776546;17819.73270400945;18308.176132074088;862.1981557151909;889.6797153024905;894.8612964990436;917.1653795046476;960.1838437328355;9196.08039196075;10014.899851001397;10074.496275186211;10106.898931010743;10444.321119127233;416057;421817;423922;424902;424926;71942.64028679823;81748.59125704452;83816.58091709502;84065.57967210124;84072;933.9766505837408;935.8362286599954;962.9422234665942;968.4963818814177;970.0881171698721;15999.68000640004;16283.348666053698;16344.836551634808;16429.260683269044;16513.66972660564;24129.758702413452;31341.216469588442;34680.479792802624;35783.82108089443;39829.822123123806;49164.262536062706;50055.74972125116;50563.49436505735;50676.239856401444;50747.746261268454;6406.775762848278;6657.167854018247;7796.376289896908;7865.292123708894;8155.673773049011;10617.89382106169;11563.537458501565;11940;11983.101267405154;12145;9037.819243615222;9469.905300947177;9785.706428807147;10271.84592231132;10274.845877311996;10088.142507886912;10097.091261786474;10100.191984641358;10137.746556335856;10162.288639795144;9722.80554388894;9820.803583928138;10049.447280399356;10374;10427.895721042996;7666.884996725165;7721.575313357819;7762.184970578008;7902.920970790448;7964.323032542299;7975.720849770462;9635;9790;10196.184305255414;10286.2799604027 00:33:21 INFO - PROCESS | 28443 | |3;mootools.html;1389.7359501694675;1433.8279406471222;1452.8329242137152;1680.806707228669;1689.180747337541;6423.6788160591905;6623.304553021935;7761.844763104742;8224.58877056147;8234.58827058647;7567.24327567243;7904;7905.130435652074;7971.521708697483;8065.2741253287195;2228.944276393087;2246.6068438023362;2253.8873056347197;2257.3115199864037;2261.027758064032;1824.5803465203012;2074.6991686205492;2137.4228958181284;2138.2516119358256;2203.5152266501345;2211.1929145861804;2234.084025549525;2237.7650346713604;2239.496113374486;2249.6288112461425;2143.9035243414082;2198.912043518257;2201.3395981205576;2204.7464541577765;2204.900779464928;2135.903884325209;2171.739391273057;2178.6514157734846;2189.2447105748493;2199.087378737822;8011.95994020032;8142.633581488788;8142.918570814334;8144.75565733029;8151.755447336589;4623.190941585242;4710.8351207707565;4726.810927562893;4737.336772851803;4737.976310118462;2831.9716802831913;2912.8543572821272;2977.211039074647;3018.335966087457;3027.6064111665564;909.0909090909091;919.2599957034585;919.4069824962928;953.4470007395694;956.8516879883629;10855.40295283759;10888.564457421693;10890.836637450444;10927.836082458769;10937.671869843838;4227.788610569459;4276.18752437036;4376.693631445832;4379.824807007748;4392.692511524227;9220.815583688423;9239.90760092404;9257.861132083024;9305.11601397866;9306.767330816649;4641.396618439581;4652.651051171176;4654.092451971833;4656.790444430008;4662.323963025342;4234.534201237861;4238.597333253336;4302.204092242945;4304.440422745086;4306.20335237982;3421.0934102462866;3450.6204317525053;3480.3561341151967;3500.1424650960166;3578.284343131384;1052.5368837711383;1054.9789004219872;1055.0451841083832;1057.154276578734;1083.285031878972;799.9000124984377;800.8598495263305;803.7829785957758;804.6459557794668;805.0661232969844;4889.584385327216;4932.136876046678;5023.422306434733;5139.691618502902;5186.688798672092;798.3054742374055;808.1474044882705;824.5629816197425;854.4403415762686;866.1291610122106;3388.847501862422;3489.3370259650587;3493.703035241982;3548.219391733866;3589.6230895756094;9648.083432073941;9817.85273220888;9863.457509837028;9947;9970.800583988424;9565.282603804742;9902.851457228147;9933.701988940344;10006.449645269435;10032.197424206046;7493.550386976799;7557;7605.6957721691615;7608;7633.69465221385;5008.3238762768015;5064.848054558369;5173.301604283524;5189.351331083614;5196.064708352533;9166.17504424605;9252.167304942588;9268.443893366419;9328.253739700944;9329.16037556623;8539.701110461105;8985.55072246372;9001.36990410665;9258.95370523143;9263.53682315895;6151.477124444473;6434.8391290218115;6655.933440665532;6675.299093595297;6808.353206445379;7661.731839385595;7676.884846727192;7710.691572337268;7715.768526944201;7752;6869.553479023847;6870.828229294308;6965.825854353681;7118.110236220473;7166.8924966124505;6483.610983341015;6646.268910419753;6661.16735408074;6693.866122677617;6864.931350686429;5953.1070339449425;6242.625442473466;6255.687215639291;6260.874782504416;6262.279837818527;4164.583541645811;4204.2432362175105;4252.596003379674;4267.317229243306;4362.214801335663;4353.521112677667;4356.455443069616;4441.755703436342;4471.28459446487;4572.45130584332 00:33:21 INFO - PROCESS | 28443 | |4;prototype.html;305.43494535110045;308.68359931070665;310.66293072016856;315.18681800953544;315.97472202223827;5063.544281014708;5066.620003499734;5067.721275329855;5073.518015788499;5096.974515127424;4948.455669876311;4963.950360496394;4984.352034235544;4994.200927851535;5005.6496045276845;3720.9813950930206;3751.362268414376;3836.673882719972;3874.244522318149;3925.6859451243977;3835.7314987950854;3890.6109389061007;3897.629725176104;3906.570277269498;3913.3542965410675;3870.20660764544;3870.3807390817474;3874.9806250968704;3888.416737489371;3888.7666739995548;3689.2990331837;3695.8521659133603;3806.562245341766;3850.1337199130253;3866.4393662919;3388.1190890368434;3412.146963259185;3416.8974930752115;3423.863045478178;3428.142964258935;4769.4515130760055;4786.832460863888;4803.375561177059;4829.275608658694;4853.975730121327;4175.895602609929;4341.674374421931;4358.8910277243;4399.758013309267;4420.823167073313;5104.336436263299;5145.948540514584;5148.198130654241;5164.767585458626;5168.371962831696;3744.812759362021;3744.9438258426144;3770.868739378203;3771.3211621908044;3772.5850156482766;5098.694078355311;5325.893482130375;5385.38808677791;5428.430014848463;5437.782488700447;3783.2622638585763;3788.2234142000825;3796;3804.771713697187;3809.771413715186;3867.845286188577;3877.2051729395407;3885.8834234972996;3904.7071469639322;3915.3735402335487;4349.391085248068;4367.279398899146;4401.691881568324;4427.80074896624;4454.420925279693;4960.925586116211;5220.9477905220465;5234.351179378484;5235.869103272373;5237.450067742909;1304.0089531955782;1333.5732565579115;1335.7328534292985;1337.2719651909995;1342.4831439895515;819.9549024803694;831.3640065350012;847.0639942863171;857.3998201259144;860.8880845490171;4419.381286619876;4541.545845415498;4566.657500687462;4572.736495434715;4585.518520555361;5337.386200586982;5348.930213957224;5363.463653634605;5379.193121031876;5414.972925135349;4435.467743870756;4492.303692927601;4513.255312873404;4544.431946006749;4575.405197324393;2830.8443035633236;2846.900358487443;2851.9732896157366;2865.3409715765492;2871.913842584726;4958.256261560723;4988.9750551247735;5015.974920125376;5027.340977477424;5064.392272927273;5236.921446178234;5494.120940649557;5499.175123731472;5499.862503437446;5506.797281087597;5005.199168133081;5006.974965125151;5026.195808670595;5050.823221187241;5102.923456148235;5330.840074797762;5365.38298095724;5387.656369479289;5395.81114660985;5461.863453413696;5010.273510341053;5289.259503669567;5309.123994540858;5363.222332761649;5420.539254163283;5052.54951348603;5096.592272618256;5118.283440318284;5127.948920353028;5140.845774626767;3798.677112445473;3835.4246862969662;3839.3665045267217;3841.8079096045644;3846.4614953905916;5234.18870075139;5491.313585801775;5493.560515158698;5511.779528818803;5513.448655134454;5223.843284701465;5230.901510682799;5240.0611773644;5253.238280449237;5270.525652691276;5249.661336359204;5266.368035835724;5268.394134674561;5272.578193744568;5286.180642000342;5049.2426136079885;5110.872228194176;5177.922331165111;5196.766145523385;5217.139172036723;5035.244713293036;5167.509086636764;5294.2852714883;5320.707361095177;5322.494363035506;5166.560842328444;5177.637565370388;5180.119379705535;5180.974095129651;5199.948000519947 00:33:21 INFO - PROCESS | 28443 | |5;yui.html;702.6346299924039;711.9430445564356;718.3570704219724;730.3645828129528;778.9415793815464;12520.686982825422;13070.346482675852;13155.4080066397;13265.27041012745;13286.13640113392;11674.066074714025;11749.177557570973;11751;11751.471183796728;11754.588589399373;613.6502193749553;752.1200195770961;785.352084530262;788.960551972402;791.3589992106412;779.6569509415867;782.968681252752;786.5673879366354;786.783634500514;786.9331106855924;656.7077650445553;827.6151589510877;828.5360198288978;829.1666874790827;829.6805729794013;645.5061877663591;655.6295692933501;670.4200866250683;755.2485277149217;782.2529484342439;566.9907564535093;567.3702190568466;568.088218409451;568.2953138108757;571.1746526269542;13047;13113.344332783417;13124.2125472471;13158.671033224151;13173.736525269536;12512.937435312857;12731.681707957283;13123;13351;13382.665433364147;9932.503374831229;10214.693559193236;10508.789824203473;10668.519916603771;10750.516226769736;4167.166566686675;4201.289504699453;4219.789010549491;4247.702660813744;4272.209641216385;58313.70843145757;58915.705421473045;59576.70211648914;59697;59859.80280394411;9940.900590994142;10178.18574514037;10352.741181470523;10367.32612380208;10454.425006624557;17351;17394.739078913826;17402.21690023952;17419.303227870743;17421.65156696859;6562.901556476657;6713.664316784141;6920.342567456084;6959.060526828915;7051.612161331176;3764.548254209458;3768.1521657626813;3813.790241536742;3832.080300727805;3916.823742931575;2945.793794434369;3034.499307614263;3040.0879736079087;3040.3919216156855;3044.4672182368;512.2035235209286;518.5825410544547;522.7229568328792;532.1087178975279;532.4994505165132;516.8165301318053;559.2059275828334;566.5354409384265;581.7091454272863;602.8944934636421;7662.923370766221;7706.422018348646;7828.882566761503;8169.142240064708;8180.9590952044855;469.98825029373853;497.09776755189216;565.4910580477521;573.2690819205546;587.8589138606703;3751.3997760358757;3768.9811550942068;3776.6978641708597;3886.436466712311;3932.4887764590994;67232.32767672358;92447;93762;95427;101103.49448252712;65963.67018164879;83384;84984.57507712545;86402.56798716092;86454;62068.37931620626;70066.29933700597;72330.63834680793;72373;75551.62224188953;7988.281054705104;8326.70856520019;8482.660693572188;8547.859550254136;8560.357973152162;43180.352294714976;43987.56012439835;44216.33675494934;44240.55759442493;44351;60046.399536005825;64327.67836160789;64626.676866615366;64797.35202647913;64879.35120648733;11188.608398706332;11191.32852028881;11226.33498176719;11428.14288928317;11781.116416268642;12940.223586584834;13114.409851556893;13243.536476223286;13632;14174;12401.193922395016;12429.875701242872;12644.810327845275;13047.869521304665;13717.657058573217;11861.822072669089;12156.574519892116;12391.62825115248;12556.811647825107;13313.068085233941;11460.083193344346;11612.593559225386;11937.880621193677;12129.636110916686;12468.314242716375;9163.633454661738;9914.157296629868;10240.64157754475;10410;10545.894541054491;10804.24370294072;10837.133029357476;10918.78162436731;11018;11061.778764424827 00:33:21 INFO - PROCESS | 28443 | __end_tp_report 00:33:21 INFO - PROCESS | 28443 | __start_cc_report 00:33:21 INFO - PROCESS | 28443 | _x_x_mozilla_cycle_collect,975 00:33:21 INFO - PROCESS | 28443 | __end_cc_report 00:33:21 INFO - PROCESS | 28443 | __startTimestamp1466667201641__endTimestamp 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | ------- Summary: start ------- 00:33:21 INFO - PROCESS | 28443 | Number of tests: 6 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#0] dojo.html Cycles:165 Average:4844.84 Median:4998.43 stddev:534.61 (10.7%) stddev-sans-first:506.94 00:33:21 INFO - PROCESS | 28443 | Values: 2619.3 2621.5 2643.3 2653.1 2660.8 4729.5 4753.5 4815.4 4849.0 4858.1 4828.0 4834.5 4838.4 4856.0 4918.8 4472.9 4481.2 4511.4 4512.7 4514.9 4469.6 4528.4 4541.0 4570.9 4625.5 4513.0 4581.9 4600.5 4601.0 4602.3 4384.5 4418.9 4440.0 4443.4 4525.0 4443.7 4443.7 4456.3 4491.9 4503.5 4995.1 4998.3 5000.0 5009.6 5014.8 5111.7 5189.9 5267.2 5267.9 5344.4 5294.7 5307.4 5340.6 5341.0 5343.3 4990.0 4998.4 5001.4 5003.9 5004.9 5274.0 5310.6 5467.5 5495.0 5511.5 5232.2 5235.3 5277.8 5286.0 5288.5 5308.1 5314.0 5324.5 5328.3 5376.1 5067.2 5094.4 5146.6 5159.7 5175.4 5165.0 5170.1 5178.4 5182.1 5238.8 4272.9 4432.5 4441.5 4448.0 4485.9 3757.1 3824.7 3853.2 3868.9 3907.1 4439.4 4456.3 4458.6 4503.5 4503.6 5154.8 5228.8 5237.3 5244.6 5292.4 4383.0 4399.7 4435.1 4456.3 4464.5 4683.0 4709.2 4711.6 4717.2 4764.9 4789.9 4892.7 4913.3 4917.6 4966.8 5188.0 5252.1 5262.5 5296.7 5319.9 4921.9 4927.1 4934.5 4963.1 4972.2 5176.4 5183.1 5186.9 5189.2 5191.3 5130.3 5236.2 5295.5 5302.4 5365.1 5152.0 5153.5 5155.3 5156.2 5183.4 5144.1 5154.3 5164.4 5167.6 5208.5 4928.7 4952.2 4981.5 5029.8 5070.1 5128.2 5150.9 5154.1 5162.4 5164.0 4952.7 5027.7 5034.7 5040.9 5082.0 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#1] ext.html Cycles:180 Average:48817.24 Median:33570.25 stddev:90957.49 (270.9%) stddev-sans-first:91140.43 00:33:21 INFO - PROCESS | 28443 | Values: 542.7 574.9 587.6 588.2 592.3 26495.0 37731.0 38347.6 38368.8 38426.2 40004.0 40531.6 40663.4 40671.0 40740.4 7521.1 7771.2 7916.7 10138.7 10409.9 10059.3 10162.4 10167.8 10176.8 10184.7 10249.3 10287.0 10301.3 10304.6 10305.7 7492.6 10145.3 10397.6 10400.0 10687.3 10180.6 10228.7 10245.0 10247.2 10255.8 37851.2 38194.0 38254.0 38257.2 38265.6 3136.0 3182.7 3195.4 3201.6 3484.3 29395.4 29468.6 29659.9 29802.7 29805.6 3513.7 3545.5 3571.4 3575.4 3622.8 388553.0 392277.0 393147.0 394581.0 394831.0 55313.7 55706.7 55899.7 55921.2 56022.7 32833.5 32992.3 33622.7 35191.5 35196.8 14038.9 14970.3 15087.2 15132.3 15269.5 11143.2 11322.8 11416.5 11520.6 11654.3 18537.0 18549.3 18580.2 18608.3 18663.0 6624.4 6730.7 6830.8 6851.3 6853.0 796.4 846.3 908.6 951.7 1029.7 27827.3 27960.0 28291.6 28689.1 28794.4 960.7 983.1 984.9 1009.5 1071.2 14866.0 15003.9 15029.8 15384.8 15401.4 380341.0 382483.0 383615.0 384513.0 385871.0 48968.3 49462.0 49587.0 49646.5 49717.8 1078.5 1163.9 1198.1 1205.9 1206.3 26955.9 28431.4 28553.1 28894.1 29108.3 40875.8 41663.2 41737.2 41809.8 41859.8 235498.0 235766.0 235772.0 236424.0 236678.0 24891.4 25897.0 26041.0 27339.2 27363.2 42469.6 42984.0 43613.1 43695.1 43848.3 35123.3 36649.8 36830.0 36944.6 37124.8 35888.5 36077.1 36089.8 36123.5 36422.5 35250.6 36267.0 36287.8 36466.6 36569.0 31804.4 32794.2 33171.2 33473.8 33517.8 25282.0 25438.5 25781.4 25939.2 26211.0 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#2] jquery.html Cycles:180 Average:24981.42 Median:4496.28 stddev:69430.57 (1544.2%) stddev-sans-first:69600.72 00:33:21 INFO - PROCESS | 28443 | Values: 353.5 370.4 374.0 376.3 391.4 16021.7 16052.3 17527.3 17547.0 17570.6 15998.5 16342.9 17079.3 17156.3 17233.4 5015.5 5169.2 5172.3 5209.1 5216.6 4998.0 5093.2 5119.5 5147.6 5161.4 5198.1 5232.9 5245.9 5249.4 5249.8 4968.8 5136.3 5164.4 5190.0 5192.0 4487.7 4504.9 4515.0 4520.3 4531.1 19554.1 20144.1 20241.5 20307.3 20983.8 1962.0 1979.6 2038.9 2521.7 2556.4 12703.6 13234.1 13321.4 13749.0 13854.3 1679.8 1746.2 1776.8 1781.3 1858.6 37391.8 55912.4 61429.7 65260.0 66337.7 9815.1 9999.6 10075.4 10152.3 10164.1 12263.4 12344.9 13164.4 13801.6 13814.8 7025.9 7042.7 7186.7 7310.7 7382.4 7189.3 7229.7 7311.9 7372.9 7373.7 5931.5 6156.9 6162.3 6207.6 6289.9 1776.0 1787.4 1787.8 1801.7 1835.4 851.6 870.7 892.4 896.6 938.4 16608.3 16973.9 17529.5 17819.7 18308.2 862.2 889.7 894.9 917.2 960.2 9196.1 10014.9 10074.5 10106.9 10444.3 416057.0 421817.0 423922.0 424902.0 424926.0 71942.6 81748.6 83816.6 84065.6 84072.0 934.0 935.8 962.9 968.5 970.1 15999.7 16283.3 16344.8 16429.3 16513.7 24129.8 31341.2 34680.5 35783.8 39829.8 49164.3 50055.7 50563.5 50676.2 50747.7 6406.8 6657.2 7796.4 7865.3 8155.7 10617.9 11563.5 11940.0 11983.1 12145.0 9037.8 9469.9 9785.7 10271.8 10274.8 10088.1 10097.1 10100.2 10137.7 10162.3 9722.8 9820.8 10049.4 10374.0 10427.9 7666.9 7721.6 7762.2 7902.9 7964.3 7975.7 9635.0 9790.0 10196.2 10286.3 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#3] mootools.html Cycles:180 Average:5171.36 Median:5044.14 stddev:2955.81 (58.6%) stddev-sans-first:2950.45 00:33:21 INFO - PROCESS | 28443 | Values: 1389.7 1433.8 1452.8 1680.8 1689.2 6423.7 6623.3 7761.8 8224.6 8234.6 7567.2 7904.0 7905.1 7971.5 8065.3 2228.9 2246.6 2253.9 2257.3 2261.0 1824.6 2074.7 2137.4 2138.3 2203.5 2211.2 2234.1 2237.8 2239.5 2249.6 2143.9 2198.9 2201.3 2204.7 2204.9 2135.9 2171.7 2178.7 2189.2 2199.1 8012.0 8142.6 8142.9 8144.8 8151.8 4623.2 4710.8 4726.8 4737.3 4738.0 2832.0 2912.9 2977.2 3018.3 3027.6 909.1 919.3 919.4 953.4 956.9 10855.4 10888.6 10890.8 10927.8 10937.7 4227.8 4276.2 4376.7 4379.8 4392.7 9220.8 9239.9 9257.9 9305.1 9306.8 4641.4 4652.7 4654.1 4656.8 4662.3 4234.5 4238.6 4302.2 4304.4 4306.2 3421.1 3450.6 3480.4 3500.1 3578.3 1052.5 1055.0 1055.0 1057.2 1083.3 799.9 800.9 803.8 804.6 805.1 4889.6 4932.1 5023.4 5139.7 5186.7 798.3 808.1 824.6 854.4 866.1 3388.8 3489.3 3493.7 3548.2 3589.6 9648.1 9817.9 9863.5 9947.0 9970.8 9565.3 9902.9 9933.7 10006.4 10032.2 7493.6 7557.0 7605.7 7608.0 7633.7 5008.3 5064.8 5173.3 5189.4 5196.1 9166.2 9252.2 9268.4 9328.3 9329.2 8539.7 8985.6 9001.4 9259.0 9263.5 6151.5 6434.8 6655.9 6675.3 6808.4 7661.7 7676.9 7710.7 7715.8 7752.0 6869.6 6870.8 6965.8 7118.1 7166.9 6483.6 6646.3 6661.2 6693.9 6864.9 5953.1 6242.6 6255.7 6260.9 6262.3 4164.6 4204.2 4252.6 4267.3 4362.2 4353.5 4356.5 4441.8 4471.3 4572.5 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#4] prototype.html Cycles:180 Average:4329.81 Median:4991.59 stddev:1264.29 (25.3%) stddev-sans-first:1231.23 00:33:21 INFO - PROCESS | 28443 | Values: 305.4 308.7 310.7 315.2 316.0 5063.5 5066.6 5067.7 5073.5 5097.0 4948.5 4964.0 4984.4 4994.2 5005.6 3721.0 3751.4 3836.7 3874.2 3925.7 3835.7 3890.6 3897.6 3906.6 3913.4 3870.2 3870.4 3875.0 3888.4 3888.8 3689.3 3695.9 3806.6 3850.1 3866.4 3388.1 3412.1 3416.9 3423.9 3428.1 4769.5 4786.8 4803.4 4829.3 4854.0 4175.9 4341.7 4358.9 4399.8 4420.8 5104.3 5145.9 5148.2 5164.8 5168.4 3744.8 3744.9 3770.9 3771.3 3772.6 5098.7 5325.9 5385.4 5428.4 5437.8 3783.3 3788.2 3796.0 3804.8 3809.8 3867.8 3877.2 3885.9 3904.7 3915.4 4349.4 4367.3 4401.7 4427.8 4454.4 4960.9 5220.9 5234.4 5235.9 5237.5 1304.0 1333.6 1335.7 1337.3 1342.5 820.0 831.4 847.1 857.4 860.9 4419.4 4541.5 4566.7 4572.7 4585.5 5337.4 5348.9 5363.5 5379.2 5415.0 4435.5 4492.3 4513.3 4544.4 4575.4 2830.8 2846.9 2852.0 2865.3 2871.9 4958.3 4989.0 5016.0 5027.3 5064.4 5236.9 5494.1 5499.2 5499.9 5506.8 5005.2 5007.0 5026.2 5050.8 5102.9 5330.8 5365.4 5387.7 5395.8 5461.9 5010.3 5289.3 5309.1 5363.2 5420.5 5052.5 5096.6 5118.3 5127.9 5140.8 3798.7 3835.4 3839.4 3841.8 3846.5 5234.2 5491.3 5493.6 5511.8 5513.4 5223.8 5230.9 5240.1 5253.2 5270.5 5249.7 5266.4 5268.4 5272.6 5286.2 5049.2 5110.9 5177.9 5196.8 5217.1 5035.2 5167.5 5294.3 5320.7 5322.5 5166.6 5177.6 5180.1 5181.0 5199.9 00:33:21 INFO - PROCESS | 28443 | 00:33:21 INFO - PROCESS | 28443 | [#5] yui.html Cycles:180 Average:17357.94 Median:44295.78 stddev:24211.90 (54.7%) stddev-sans-first:24247.52 00:33:21 INFO - PROCESS | 28443 | Values: 702.6 711.9 718.4 730.4 778.9 12520.7 13070.3 13155.4 13265.3 13286.1 11674.1 11749.2 11751.0 11751.5 11754.6 613.7 752.1 785.4 789.0 791.4 779.7 783.0 786.6 786.8 786.9 656.7 827.6 828.5 829.2 829.7 645.5 655.6 670.4 755.2 782.3 567.0 567.4 568.1 568.3 571.2 13047.0 13113.3 13124.2 13158.7 13173.7 12512.9 12731.7 13123.0 13351.0 13382.7 9932.5 10214.7 10508.8 10668.5 10750.5 4167.2 4201.3 4219.8 4247.7 4272.2 58313.7 58915.7 59576.7 59697.0 59859.8 9940.9 10178.2 10352.7 10367.3 10454.4 17351.0 17394.7 17402.2 17419.3 17421.7 6562.9 6713.7 6920.3 6959.1 7051.6 3764.5 3768.2 3813.8 3832.1 3916.8 2945.8 3034.5 3040.1 3040.4 3044.5 512.2 518.6 522.7 532.1 532.5 516.8 559.2 566.5 581.7 602.9 7662.9 7706.4 7828.9 8169.1 8181.0 470.0 497.1 565.5 573.3 587.9 3751.4 3769.0 3776.7 3886.4 3932.5 67232.3 92447.0 93762.0 95427.0 101103.5 65963.7 83384.0 84984.6 86402.6 86454.0 62068.4 70066.3 72330.6 72373.0 75551.6 7988.3 8326.7 8482.7 8547.9 8560.4 43180.4 43987.6 44216.3 44240.6 44351.0 60046.4 64327.7 64626.7 64797.4 64879.4 11188.6 11191.3 11226.3 11428.1 11781.1 12940.2 13114.4 13243.5 13632.0 14174.0 12401.2 12429.9 12644.8 13047.9 13717.7 11861.8 12156.6 12391.6 12556.8 13313.1 11460.1 11612.6 11937.9 12129.6 12468.3 9163.6 9914.2 10240.6 10410.0 10545.9 10804.2 10837.1 10918.8 11018.0 11061.8 00:33:21 INFO - PROCESS | 28443 | -------- Summary: end -------- 00:33:21 INFO - PROCESS | 28443 | 00:33:22 INFO - TEST-INFO | 28443: exit 0 00:33:22 INFO - TEST-OK | dromaeo_css | took 1119106ms 00:33:22 INFO - TEST-START | kraken 00:33:22 INFO - operating with platform_type : linux_ 00:33:22 INFO - Initialising browser for kraken test... 00:33:22 INFO - TEST-INFO | started process 28621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJMe0G/profile http://localhost:50471/getInfo.html) 00:33:26 INFO - PROCESS | 28621 | __metrics Screen width/height:1600/1200 00:33:26 INFO - PROCESS | 28621 | colorDepth:24 00:33:26 INFO - PROCESS | 28621 | Browser inner width/height: 1024/697 00:33:26 INFO - PROCESS | 28621 | __metrics 00:33:27 INFO - PROCESS | 28621 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:33:27 INFO - TEST-INFO | 28621: exit 0 00:33:27 INFO - Browser initialized. 00:33:27 INFO - Running cycle 1/1 for kraken test... 00:33:27 INFO - TEST-INFO | started process 28700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJMe0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:33:40 INFO - PROCESS | 28700 | RSS: Main: 175595520 00:33:40 INFO - PROCESS | 28700 | 00:33:42 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50471/tests/kraken/driver.html?testName=audio-beat-detection) 00:33:43 INFO - PROCESS | 28700 | RSS: Main: 233549824 00:33:43 INFO - PROCESS | 28700 | 00:33:46 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50471/tests/kraken/driver.html?testName=audio-dft) 00:33:47 INFO - PROCESS | 28700 | RSS: Main: 224804864 00:33:47 INFO - PROCESS | 28700 | 00:33:50 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50471/tests/kraken/driver.html?testName=audio-fft) 00:33:51 INFO - PROCESS | 28700 | RSS: Main: 288915456 00:33:51 INFO - PROCESS | 28700 | 00:33:53 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50471/tests/kraken/driver.html?testName=audio-oscillator) 00:33:53 INFO - PROCESS | 28700 | RSS: Main: 199737344 00:33:53 INFO - PROCESS | 28700 | 00:33:56 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:33:56 INFO - PROCESS | 28700 | RSS: Main: 203284480 00:33:56 INFO - PROCESS | 28700 | 00:33:59 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50471/tests/kraken/driver.html?testName=imaging-darkroom) 00:34:00 INFO - PROCESS | 28700 | RSS: Main: 239140864 00:34:00 INFO - PROCESS | 28700 | 00:34:04 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50471/tests/kraken/driver.html?testName=imaging-desaturate) 00:34:04 INFO - PROCESS | 28700 | RSS: Main: 234704896 00:34:04 INFO - PROCESS | 28700 | 00:34:07 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50471/tests/kraken/driver.html?testName=json-parse-financial) 00:34:08 INFO - PROCESS | 28700 | RSS: Main: 237158400 00:34:08 INFO - PROCESS | 28700 | 00:34:09 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:34:10 INFO - PROCESS | 28700 | RSS: Main: 225587200 00:34:10 INFO - PROCESS | 28700 | 00:34:12 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:34:13 INFO - PROCESS | 28700 | RSS: Main: 231600128 00:34:13 INFO - PROCESS | 28700 | 00:34:15 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:34:15 INFO - PROCESS | 28700 | RSS: Main: 239427584 00:34:15 INFO - PROCESS | 28700 | 00:34:18 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:34:19 INFO - PROCESS | 28700 | RSS: Main: 241070080 00:34:19 INFO - PROCESS | 28700 | 00:34:22 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:34:22 INFO - PROCESS | 28700 | RSS: Main: 240226304 00:34:22 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | Cycle 1(1): loaded http://localhost:50471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50471/tests/kraken/driver.html?testName=ai-astar) 00:34:24 INFO - PROCESS | 28700 | RSS: Main: 283586560 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | __start_tp_report 00:34:24 INFO - PROCESS | 28700 | _x_x_mozilla_page_load 00:34:24 INFO - PROCESS | 28700 | _x_x_mozilla_page_load_details 00:34:24 INFO - PROCESS | 28700 | |i|pagename|runs| 00:34:24 INFO - PROCESS | 28700 | |0;ai-astar;103;116;113;113;115;114;115;113;114;112 00:34:24 INFO - PROCESS | 28700 | |1;audio-beat-detection;157;131;139;185;147;161;152;131;192;130 00:34:24 INFO - PROCESS | 28700 | |2;audio-dft;162;163;163;163;162;162;164;160;161;161 00:34:24 INFO - PROCESS | 28700 | |3;audio-fft;76;77;79;120;75;76;76;75;99;77 00:34:24 INFO - PROCESS | 28700 | |4;audio-oscillator;87;86;119;86;86;87;124;86;85;129 00:34:24 INFO - PROCESS | 28700 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 00:34:24 INFO - PROCESS | 28700 | |6;imaging-darkroom;148;147;148;149;150;148;147;147;147;147 00:34:24 INFO - PROCESS | 28700 | |7;imaging-desaturate;94;94;95;95;95;96;95;94;95;94 00:34:24 INFO - PROCESS | 28700 | |8;json-parse-financial;64;64;64;64;64;65;63;64;64;63 00:34:24 INFO - PROCESS | 28700 | |9;json-stringify-tinderbox;65;65;65;68;66;65;65;65;66;65 00:34:24 INFO - PROCESS | 28700 | |10;stanford-crypto-aes;81;82;82;84;90;92;83;89;110;87 00:34:24 INFO - PROCESS | 28700 | |11;stanford-crypto-ccm;152;130;135;134;131;137;126;136;135;133 00:34:24 INFO - PROCESS | 28700 | |12;stanford-crypto-pbkdf2;170;169;169;171;169;167;167;171;170;168 00:34:24 INFO - PROCESS | 28700 | |13;stanford-crypto-sha256-iterative;68;69;70;67;67;70;69;67;65;66 00:34:24 INFO - PROCESS | 28700 | __end_tp_report 00:34:24 INFO - PROCESS | 28700 | __start_cc_report 00:34:24 INFO - PROCESS | 28700 | _x_x_mozilla_cycle_collect,1916 00:34:24 INFO - PROCESS | 28700 | __end_cc_report 00:34:24 INFO - PROCESS | 28700 | __startTimestamp1466667264825__endTimestamp 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | ------- Summary: start ------- 00:34:24 INFO - PROCESS | 28700 | Number of tests: 14 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.65 (3.2%) stddev-sans-first:1.27 00:34:24 INFO - PROCESS | 28700 | Values: 103.0 116.0 113.0 113.0 115.0 114.0 115.0 113.0 114.0 112.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:154.50 stddev:21.99 (14.2%) stddev-sans-first:23.26 00:34:24 INFO - PROCESS | 28700 | Values: 157.0 131.0 139.0 185.0 147.0 161.0 152.0 131.0 192.0 130.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 00:34:24 INFO - PROCESS | 28700 | Values: 162.0 163.0 163.0 163.0 162.0 162.0 164.0 160.0 161.0 161.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:14.86 (19.4%) stddev-sans-first:15.55 00:34:24 INFO - PROCESS | 28700 | Values: 76.0 77.0 79.0 120.0 75.0 76.0 76.0 75.0 99.0 77.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.00 stddev:18.45 (21.4%) stddev-sans-first:19.17 00:34:24 INFO - PROCESS | 28700 | Values: 87.0 86.0 119.0 86.0 86.0 87.0 124.0 86.0 85.0 129.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:34:24 INFO - PROCESS | 28700 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 00:34:24 INFO - PROCESS | 28700 | Values: 148.0 147.0 148.0 149.0 150.0 148.0 147.0 147.0 147.0 147.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 00:34:24 INFO - PROCESS | 28700 | Values: 94.0 94.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 94.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 00:34:24 INFO - PROCESS | 28700 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 63.0 64.0 64.0 63.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 00:34:24 INFO - PROCESS | 28700 | Values: 65.0 65.0 65.0 68.0 66.0 65.0 65.0 65.0 66.0 65.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:85.50 stddev:8.62 (10.1%) stddev-sans-first:8.76 00:34:24 INFO - PROCESS | 28700 | Values: 81.0 82.0 82.0 84.0 90.0 92.0 83.0 89.0 110.0 87.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:135.00 stddev:6.84 (5.1%) stddev-sans-first:3.46 00:34:24 INFO - PROCESS | 28700 | Values: 152.0 130.0 135.0 134.0 131.0 137.0 126.0 136.0 135.0 133.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:1.45 (0.9%) stddev-sans-first:1.50 00:34:24 INFO - PROCESS | 28700 | Values: 170.0 169.0 169.0 171.0 169.0 167.0 167.0 171.0 170.0 168.0 00:34:24 INFO - PROCESS | 28700 | 00:34:24 INFO - PROCESS | 28700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.69 (2.5%) stddev-sans-first:1.79 00:34:24 INFO - PROCESS | 28700 | Values: 68.0 69.0 70.0 67.0 67.0 70.0 69.0 67.0 65.0 66.0 00:34:24 INFO - PROCESS | 28700 | -------- Summary: end -------- 00:34:24 INFO - PROCESS | 28700 | 00:34:25 INFO - TEST-INFO | 28700: exit 0 00:34:25 INFO - TEST-OK | kraken | took 63566ms 00:34:25 INFO - SUITE-END | took 1182s 00:34:25 INFO - Completed test suite (00:19:42) 00:34:25 INFO - javascript benchmark 00:34:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.3189770659624, 2621.462600166966, 2643.2863126955717, 2653.0979466981235, 2660.76053155216, 4729.456112547058, 4753.548412900777, 4815.422149342084, 4848.999999999995, 4858.07696537658, 4827.951720482794, 4834.468208497063, 4838.443578988417, 4855.975720121394, 4918.803247870081, 4472.910541789162, 4481.170983368071, 4511.436070491189, 4512.706674066175, 4514.932276015862, 4469.620082293009, 4528.366028755977, 4540.954590454103, 4570.908581828378, 4625.537446255365, 4513.0, 4581.9312710309205, 4600.516945720701, 4600.953990460102, 4602.309653551961, 4384.539623339567, 4418.911621767579, 4440.02319489715, 4443.4445694288215, 4524.977375113136, 4443.666724995606, 4443.688941774045, 4456.2647163218035, 4491.887702807423, 4503.482099558527, 4995.125852975715, 4998.250262460624, 4999.999999999978, 5009.649324547283, 5014.774335154927, 5111.693298402108, 5189.922151167735, 5267.236250743659, 5267.86830329241, 5344.385395679507, 5294.735263236861, 5307.442718514539, 5340.599455040888, 5341.0, 5343.305370301836, 4989.999999999964, 4998.425181104147, 5001.42483614389, 5003.874903127378, 5004.924926126111, 5274.024305503417, 5310.575153987672, 5467.4532546745, 5495.0383682855345, 5511.53151982086, 5232.2413250078525, 5235.345581802275, 5277.8416647500635, 5286.022085914041, 5288.497592728685, 5308.071087559739, 5313.973430132902, 5324.547413469899, 5328.280682107943, 5376.1398176291605, 5067.1639179535705, 5094.439611642716, 5146.562542183956, 5159.664621799571, 5175.430702622709, 5165.0, 5170.121079416508, 5178.352705911761, 5182.1190397631735, 5238.764255608507, 4272.91454170921, 4432.534583868712, 4441.511433742286, 4448.0, 4485.865424037219, 3757.1358587525024, 3824.694024478035, 3853.190829925747, 3868.941965870514, 3907.1404291055924, 4439.42287502629, 4456.264716321771, 4458.554144585515, 4503.504614492469, 4503.617192538671, 5154.768035438415, 5228.764705588258, 5237.319148510745, 5244.606654500928, 5292.391374991848, 4382.978085109554, 4399.670024748157, 4435.090806384684, 4456.331550267421, 4464.464264288241, 4682.993156471375, 4709.199436095803, 4711.623070154448, 4717.245240761462, 4764.928526072112, 4789.904201915872, 4892.706437613754, 4913.336699545515, 4917.557419832232, 4966.826161084273, 5187.974060129826, 5252.133397989289, 5262.500062494057, 5296.682199068068, 5319.9468005321, 4921.876953076202, 4927.088488629615, 4934.5312195341385, 4963.10664080469, 4972.179590367549, 5176.352955880515, 5183.067047931258, 5186.8962620748125, 5189.247559103834, 5191.32512773337, 5130.256112863689, 5236.240745092016, 5295.470452954828, 5302.3637163540625, 5365.061114305059, 5152.0, 5153.510416510426, 5155.2782610433815, 5156.1750119980625, 5183.377994640668, 5144.125498665161, 5154.252633368065, 5164.406093299319, 5167.61242906791, 5208.5312321891215, 4928.704277743347, 4952.232403977389, 4981.476944920876, 5029.823956161663, 5070.087384270867, 5128.205128205134, 5150.948490515047, 5154.123798954111, 5162.432132465351, 5164.04465173944, 4952.653314267966, 5027.698338099725, 5034.697918124924, 5040.899182016413, 5082.0], "value": 4808.422394080484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.7408412483038, 574.8907707535568, 587.6063037764698, 588.1706793421274, 592.2537602620698, 26495.0, 37731.0, 38347.61652383475, 38368.80815595918, 38426.23147537054, 40004.0, 40531.594684053154, 40663.39004914929, 40671.0, 40740.38889416661, 7521.135069466999, 7771.222877712212, 7916.722914697987, 10138.6958391248, 10409.895901040969, 10059.34614250075, 10162.441065741417, 10167.796644067113, 10176.79646407075, 10184.694459166238, 10249.333793303449, 10287.045461362355, 10301.27891047627, 10304.587816487368, 10305.690829275134, 7492.625368731569, 10145.289829711923, 10397.584096636125, 10400.0, 10687.30532515384, 10180.592776289013, 10228.693139205836, 10245.0, 10247.231457640706, 10255.794884102275, 37851.242975140616, 38194.0, 38254.0, 38257.17428257152, 38265.617343826765, 3135.984320078408, 3182.7294679952233, 3195.392875353675, 3201.6478187399366, 3484.285721427101, 29395.41209175826, 29468.557971630442, 29659.94115802223, 29802.70197298021, 29805.552916706267, 3513.7189024878203, 3545.4859045438525, 3571.4107172316794, 3575.410057340536, 3622.8188590570367, 388553.0, 392277.0, 393147.0, 394581.0, 394831.0, 55313.72343138258, 55706.72146639241, 55899.720501397234, 55921.16118258229, 56022.71988640112, 32833.50749738756, 32992.340153196805, 33622.663773362445, 35191.4721279181, 35196.76811311592, 14038.929805350908, 14970.326335314938, 15087.24563771807, 15132.319045642973, 15269.541913742605, 11143.16426268017, 11322.830157547643, 11416.486258118404, 11520.596779112691, 11654.30074195551, 18536.960934297218, 18549.258029678662, 18580.163892624594, 18608.34870779516, 18663.0, 6624.436922861514, 6730.697118629673, 6830.7609233676585, 6851.3491218334175, 6853.0, 796.3708670150633, 846.2679781988536, 908.6456282050005, 951.6526467839327, 1029.7219750667277, 27827.304317392227, 27960.0, 28291.575626365622, 28689.13932582026, 28794.424111517652, 960.7213907966751, 983.1151963233148, 984.921206303494, 1009.5305682857506, 1071.23406764164, 14866.0, 15003.924980375028, 15029.774553381709, 15384.846151538566, 15401.383944642088, 380341.0, 382483.0, 383615.0, 384513.0, 385871.0, 48968.265476017885, 49462.0, 49587.0, 49646.50353496491, 49717.75141124344, 1078.5470102556944, 1163.9301641901682, 1198.113396086907, 1205.9336736479577, 1206.3003457994341, 26955.86522067377, 28431.431371372044, 28553.14340569786, 28894.133176004754, 29108.27229319284, 40875.7956210217, 41663.16673666449, 41737.16525669409, 41809.79095104505, 41859.7907010463, 235498.0, 235766.0, 235772.0, 236424.0, 236678.0, 24891.377715557257, 25897.0, 26041.0, 27339.179824605293, 27363.17910462689, 42469.575304247795, 42984.0, 43613.127737445706, 43695.12609747851, 43848.34227486654, 35123.29753404867, 36649.81675091608, 36830.0, 36944.63055369519, 37124.81437592795, 35888.4616730744, 36077.0980725484, 36089.81955090313, 36123.458148127276, 36422.4536631956, 35250.59367579053, 36267.0, 36287.81856090703, 36466.63533364632, 36569.0, 31804.363912721154, 32794.18014549655, 33171.170720732174, 33473.83263083669, 33517.83241083779, 25282.0, 25438.49123017492, 25781.3554661135, 25939.22182334533, 26211.0], "value": 18072.905605853128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.53157066886365, 370.3833117858765, 373.97569158004734, 376.2662807525326, 391.38747859599727, 16021.679566408664, 16052.277647505862, 17527.298908043664, 17547.0, 17570.560735981606, 15998.520044398687, 16342.918285408587, 17079.316827326893, 17156.31374745012, 17233.396831110913, 5015.523525265103, 5169.224616307565, 5172.27588137661, 5209.1404918188455, 5216.582673386139, 4998.025385049898, 5093.185090385539, 5119.539241468267, 5147.613928955325, 5161.4322424533275, 5198.064348417283, 5232.947670523284, 5245.868853278679, 5249.370075590915, 5249.842504724865, 4968.776405061781, 5136.280920671109, 5164.431912489623, 5189.974050129763, 5191.974040129794, 4487.6634252431195, 4504.8873778155485, 4515.029268707243, 4520.254158063915, 4531.116432295704, 19554.120064597126, 20144.09351579168, 20241.493962650904, 20307.289244876505, 20983.790162098336, 1961.990190049055, 1979.5743915058188, 2038.8776673399643, 2521.735217802123, 2556.412025234188, 12703.618891433272, 13234.139780914305, 13321.40053697586, 13749.037567370287, 13854.307284635828, 1679.82361852005, 1746.1531157388783, 1776.7956684981264, 1781.3141940352928, 1858.5539470527112, 37391.813040934896, 55912.44087559113, 61429.69285153546, 65260.0, 66337.66831165813, 9815.067568580973, 9999.55002024896, 10075.445850478147, 10152.289339746294, 10164.085232328978, 12263.448144833505, 12344.938275308567, 13164.40760165795, 13801.585952421443, 13814.792778108336, 7025.92974070263, 7042.718291268292, 7186.7125314986815, 7310.744123955636, 7382.446316526175, 7189.3170148836825, 7229.674664640103, 7311.853762924712, 7372.889406658905, 7373.668184931691, 5931.466168044896, 6156.8768624627255, 6162.291336496271, 6207.6275423473835, 6289.937100628935, 1775.9822401776075, 1787.428023032643, 1787.8480329171905, 1801.738747881576, 1835.431016384925, 851.6295411496019, 870.7039606533682, 892.3530440430766, 896.6413434626202, 938.4181807279394, 16608.335666573443, 16973.915130424517, 17529.474115776546, 17819.73270400945, 18308.176132074088, 862.1981557151909, 889.6797153024905, 894.8612964990436, 917.1653795046476, 960.1838437328355, 9196.08039196075, 10014.899851001397, 10074.496275186211, 10106.898931010743, 10444.321119127233, 416057.0, 421817.0, 423922.0, 424902.0, 424926.0, 71942.64028679823, 81748.59125704452, 83816.58091709502, 84065.57967210124, 84072.0, 933.9766505837408, 935.8362286599954, 962.9422234665942, 968.4963818814177, 970.0881171698721, 15999.68000640004, 16283.348666053698, 16344.836551634808, 16429.260683269044, 16513.66972660564, 24129.758702413452, 31341.216469588442, 34680.479792802624, 35783.82108089443, 39829.822123123806, 49164.262536062706, 50055.74972125116, 50563.49436505735, 50676.239856401444, 50747.746261268454, 6406.775762848278, 6657.167854018247, 7796.376289896908, 7865.292123708894, 8155.673773049011, 10617.89382106169, 11563.537458501565, 11940.0, 11983.101267405154, 12145.0, 9037.819243615222, 9469.905300947177, 9785.706428807147, 10271.84592231132, 10274.845877311996, 10088.142507886912, 10097.091261786474, 10100.191984641358, 10137.746556335856, 10162.288639795144, 9722.80554388894, 9820.803583928138, 10049.447280399356, 10374.0, 10427.895721042996, 7666.884996725165, 7721.575313357819, 7762.184970578008, 7902.920970790448, 7964.323032542299, 7975.720849770462, 9635.0, 9790.0, 10196.184305255414, 10286.2799604027], "value": 8305.30620582434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.7359501694675, 1433.8279406471222, 1452.8329242137152, 1680.806707228669, 1689.180747337541, 6423.6788160591905, 6623.304553021935, 7761.844763104742, 8224.58877056147, 8234.58827058647, 7567.24327567243, 7904.0, 7905.130435652074, 7971.521708697483, 8065.2741253287195, 2228.944276393087, 2246.6068438023362, 2253.8873056347197, 2257.3115199864037, 2261.027758064032, 1824.5803465203012, 2074.6991686205492, 2137.4228958181284, 2138.2516119358256, 2203.5152266501345, 2211.1929145861804, 2234.084025549525, 2237.7650346713604, 2239.496113374486, 2249.6288112461425, 2143.9035243414082, 2198.912043518257, 2201.3395981205576, 2204.7464541577765, 2204.900779464928, 2135.903884325209, 2171.739391273057, 2178.6514157734846, 2189.2447105748493, 2199.087378737822, 8011.95994020032, 8142.633581488788, 8142.918570814334, 8144.75565733029, 8151.755447336589, 4623.190941585242, 4710.8351207707565, 4726.810927562893, 4737.336772851803, 4737.976310118462, 2831.9716802831913, 2912.8543572821272, 2977.211039074647, 3018.335966087457, 3027.6064111665564, 909.0909090909091, 919.2599957034585, 919.4069824962928, 953.4470007395694, 956.8516879883629, 10855.40295283759, 10888.564457421693, 10890.836637450444, 10927.836082458769, 10937.671869843838, 4227.788610569459, 4276.18752437036, 4376.693631445832, 4379.824807007748, 4392.692511524227, 9220.815583688423, 9239.90760092404, 9257.861132083024, 9305.11601397866, 9306.767330816649, 4641.396618439581, 4652.651051171176, 4654.092451971833, 4656.790444430008, 4662.323963025342, 4234.534201237861, 4238.597333253336, 4302.204092242945, 4304.440422745086, 4306.20335237982, 3421.0934102462866, 3450.6204317525053, 3480.3561341151967, 3500.1424650960166, 3578.284343131384, 1052.5368837711383, 1054.9789004219872, 1055.0451841083832, 1057.154276578734, 1083.285031878972, 799.9000124984377, 800.8598495263305, 803.7829785957758, 804.6459557794668, 805.0661232969844, 4889.584385327216, 4932.136876046678, 5023.422306434733, 5139.691618502902, 5186.688798672092, 798.3054742374055, 808.1474044882705, 824.5629816197425, 854.4403415762686, 866.1291610122106, 3388.847501862422, 3489.3370259650587, 3493.703035241982, 3548.219391733866, 3589.6230895756094, 9648.083432073941, 9817.85273220888, 9863.457509837028, 9947.0, 9970.800583988424, 9565.282603804742, 9902.851457228147, 9933.701988940344, 10006.449645269435, 10032.197424206046, 7493.550386976799, 7557.0, 7605.6957721691615, 7608.0, 7633.69465221385, 5008.3238762768015, 5064.848054558369, 5173.301604283524, 5189.351331083614, 5196.064708352533, 9166.17504424605, 9252.167304942588, 9268.443893366419, 9328.253739700944, 9329.16037556623, 8539.701110461105, 8985.55072246372, 9001.36990410665, 9258.95370523143, 9263.53682315895, 6151.477124444473, 6434.8391290218115, 6655.933440665532, 6675.299093595297, 6808.353206445379, 7661.731839385595, 7676.884846727192, 7710.691572337268, 7715.768526944201, 7752.0, 6869.553479023847, 6870.828229294308, 6965.825854353681, 7118.110236220473, 7166.8924966124505, 6483.610983341015, 6646.268910419753, 6661.16735408074, 6693.866122677617, 6864.931350686429, 5953.1070339449425, 6242.625442473466, 6255.687215639291, 6260.874782504416, 6262.279837818527, 4164.583541645811, 4204.2432362175105, 4252.596003379674, 4267.317229243306, 4362.214801335663, 4353.521112677667, 4356.455443069616, 4441.755703436342, 4471.28459446487, 4572.45130584332], "value": 4134.240308447207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.43494535110045, 308.68359931070665, 310.66293072016856, 315.18681800953544, 315.97472202223827, 5063.544281014708, 5066.620003499734, 5067.721275329855, 5073.518015788499, 5096.974515127424, 4948.455669876311, 4963.950360496394, 4984.352034235544, 4994.200927851535, 5005.6496045276845, 3720.9813950930206, 3751.362268414376, 3836.673882719972, 3874.244522318149, 3925.6859451243977, 3835.7314987950854, 3890.6109389061007, 3897.629725176104, 3906.570277269498, 3913.3542965410675, 3870.20660764544, 3870.3807390817474, 3874.9806250968704, 3888.416737489371, 3888.7666739995548, 3689.2990331837, 3695.8521659133603, 3806.562245341766, 3850.1337199130253, 3866.4393662919, 3388.1190890368434, 3412.146963259185, 3416.8974930752115, 3423.863045478178, 3428.142964258935, 4769.4515130760055, 4786.832460863888, 4803.375561177059, 4829.275608658694, 4853.975730121327, 4175.895602609929, 4341.674374421931, 4358.8910277243, 4399.758013309267, 4420.823167073313, 5104.336436263299, 5145.948540514584, 5148.198130654241, 5164.767585458626, 5168.371962831696, 3744.812759362021, 3744.9438258426144, 3770.868739378203, 3771.3211621908044, 3772.5850156482766, 5098.694078355311, 5325.893482130375, 5385.38808677791, 5428.430014848463, 5437.782488700447, 3783.2622638585763, 3788.2234142000825, 3796.0, 3804.771713697187, 3809.771413715186, 3867.845286188577, 3877.2051729395407, 3885.8834234972996, 3904.7071469639322, 3915.3735402335487, 4349.391085248068, 4367.279398899146, 4401.691881568324, 4427.80074896624, 4454.420925279693, 4960.925586116211, 5220.9477905220465, 5234.351179378484, 5235.869103272373, 5237.450067742909, 1304.0089531955782, 1333.5732565579115, 1335.7328534292985, 1337.2719651909995, 1342.4831439895515, 819.9549024803694, 831.3640065350012, 847.0639942863171, 857.3998201259144, 860.8880845490171, 4419.381286619876, 4541.545845415498, 4566.657500687462, 4572.736495434715, 4585.518520555361, 5337.386200586982, 5348.930213957224, 5363.463653634605, 5379.193121031876, 5414.972925135349, 4435.467743870756, 4492.303692927601, 4513.255312873404, 4544.431946006749, 4575.405197324393, 2830.8443035633236, 2846.900358487443, 2851.9732896157366, 2865.3409715765492, 2871.913842584726, 4958.256261560723, 4988.9750551247735, 5015.974920125376, 5027.340977477424, 5064.392272927273, 5236.921446178234, 5494.120940649557, 5499.175123731472, 5499.862503437446, 5506.797281087597, 5005.199168133081, 5006.974965125151, 5026.195808670595, 5050.823221187241, 5102.923456148235, 5330.840074797762, 5365.38298095724, 5387.656369479289, 5395.81114660985, 5461.863453413696, 5010.273510341053, 5289.259503669567, 5309.123994540858, 5363.222332761649, 5420.539254163283, 5052.54951348603, 5096.592272618256, 5118.283440318284, 5127.948920353028, 5140.845774626767, 3798.677112445473, 3835.4246862969662, 3839.3665045267217, 3841.8079096045644, 3846.4614953905916, 5234.18870075139, 5491.313585801775, 5493.560515158698, 5511.779528818803, 5513.448655134454, 5223.843284701465, 5230.901510682799, 5240.0611773644, 5253.238280449237, 5270.525652691276, 5249.661336359204, 5266.368035835724, 5268.394134674561, 5272.578193744568, 5286.180642000342, 5049.2426136079885, 5110.872228194176, 5177.922331165111, 5196.766145523385, 5217.139172036723, 5035.244713293036, 5167.509086636764, 5294.2852714883, 5320.707361095177, 5322.494363035506, 5166.560842328444, 5177.637565370388, 5180.119379705535, 5180.974095129651, 5199.948000519947], "value": 3925.8676874316025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.6346299924039, 711.9430445564356, 718.3570704219724, 730.3645828129528, 778.9415793815464, 12520.686982825422, 13070.346482675852, 13155.4080066397, 13265.27041012745, 13286.13640113392, 11674.066074714025, 11749.177557570973, 11751.0, 11751.471183796728, 11754.588589399373, 613.6502193749553, 752.1200195770961, 785.352084530262, 788.960551972402, 791.3589992106412, 779.6569509415867, 782.968681252752, 786.5673879366354, 786.783634500514, 786.9331106855924, 656.7077650445553, 827.6151589510877, 828.5360198288978, 829.1666874790827, 829.6805729794013, 645.5061877663591, 655.6295692933501, 670.4200866250683, 755.2485277149217, 782.2529484342439, 566.9907564535093, 567.3702190568466, 568.088218409451, 568.2953138108757, 571.1746526269542, 13047.0, 13113.344332783417, 13124.2125472471, 13158.671033224151, 13173.736525269536, 12512.937435312857, 12731.681707957283, 13123.0, 13351.0, 13382.665433364147, 9932.503374831229, 10214.693559193236, 10508.789824203473, 10668.519916603771, 10750.516226769736, 4167.166566686675, 4201.289504699453, 4219.789010549491, 4247.702660813744, 4272.209641216385, 58313.70843145757, 58915.705421473045, 59576.70211648914, 59697.0, 59859.80280394411, 9940.900590994142, 10178.18574514037, 10352.741181470523, 10367.32612380208, 10454.425006624557, 17351.0, 17394.739078913826, 17402.21690023952, 17419.303227870743, 17421.65156696859, 6562.901556476657, 6713.664316784141, 6920.342567456084, 6959.060526828915, 7051.612161331176, 3764.548254209458, 3768.1521657626813, 3813.790241536742, 3832.080300727805, 3916.823742931575, 2945.793794434369, 3034.499307614263, 3040.0879736079087, 3040.3919216156855, 3044.4672182368, 512.2035235209286, 518.5825410544547, 522.7229568328792, 532.1087178975279, 532.4994505165132, 516.8165301318053, 559.2059275828334, 566.5354409384265, 581.7091454272863, 602.8944934636421, 7662.923370766221, 7706.422018348646, 7828.882566761503, 8169.142240064708, 8180.9590952044855, 469.98825029373853, 497.09776755189216, 565.4910580477521, 573.2690819205546, 587.8589138606703, 3751.3997760358757, 3768.9811550942068, 3776.6978641708597, 3886.436466712311, 3932.4887764590994, 67232.32767672358, 92447.0, 93762.0, 95427.0, 101103.49448252712, 65963.67018164879, 83384.0, 84984.57507712545, 86402.56798716092, 86454.0, 62068.37931620626, 70066.29933700597, 72330.63834680793, 72373.0, 75551.62224188953, 7988.281054705104, 8326.70856520019, 8482.660693572188, 8547.859550254136, 8560.357973152162, 43180.352294714976, 43987.56012439835, 44216.33675494934, 44240.55759442493, 44351.0, 60046.399536005825, 64327.67836160789, 64626.676866615366, 64797.35202647913, 64879.35120648733, 11188.608398706332, 11191.32852028881, 11226.33498176719, 11428.14288928317, 11781.116416268642, 12940.223586584834, 13114.409851556893, 13243.536476223286, 13632.0, 14174.0, 12401.193922395016, 12429.875701242872, 12644.810327845275, 13047.869521304665, 13717.657058573217, 11861.822072669089, 12156.574519892116, 12391.62825115248, 12556.811647825107, 13313.068085233941, 11460.083193344346, 11612.593559225386, 11937.880621193677, 12129.636110916686, 12468.314242716375, 9163.633454661738, 9914.157296629868, 10240.64157754475, 10410.0, 10545.894541054491, 10804.24370294072, 10837.133029357476, 10918.78162436731, 11018.0, 11061.778764424827], "value": 6552.623149654599, "unit": "score"}], "name": "dromaeo_css", "value": 6519.239657507461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 113.0, 113.0, 115.0, 114.0, 115.0, 113.0, 114.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 139.0, 185.0, 147.0, 161.0, 152.0, 131.0, 192.0, 130.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 164.0, 160.0, 161.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 120.0, 75.0, 76.0, 76.0, 75.0, 99.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 119.0, 86.0, 86.0, 87.0, 124.0, 86.0, 85.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 150.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 84.0, 90.0, 92.0, 83.0, 89.0, 110.0, 87.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 135.0, 134.0, 131.0, 137.0, 126.0, 136.0, 135.0, 133.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 169.0, 171.0, 169.0, 167.0, 167.0, 171.0, 170.0, 168.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 67.0, 67.0, 70.0, 69.0, 67.0, 65.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1556.5, "alertThreshold": 2.0}]} 00:34:26 INFO - Return code: 0 00:34:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:34:26 INFO - # TBPL SUCCESS # 00:34:26 INFO - Running post-action listener: _resource_record_post_action 00:34:26 INFO - ##### 00:34:26 INFO - ##### Finished run-tests step (success) 00:34:26 INFO - ##### 00:34:26 INFO - Running post-run listener: _resource_record_post_run 00:34:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534704128; Read time: 20; Write time: 495312 00:34:26 INFO - TinderboxPrint: CPU usage
13.2% 00:34:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 00:34:26 INFO - TinderboxPrint: I/O write bytes / time
534,704,128 / 495,312 00:34:26 INFO - TinderboxPrint: CPU idle
8,313.9 (86.8%) 00:34:26 INFO - TinderboxPrint: CPU user
1,217.3 (12.7%) 00:34:26 INFO - TinderboxPrint: Swap in / out
0 / 0 00:34:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244174848; Read time: 0; Write time: 276124 00:34:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288616448; Read time: 20; Write time: 218876 00:34:26 INFO - Running post-run listener: _upload_blobber_files 00:34:26 INFO - Blob upload gear active. 00:34:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:34:26 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 00:34:26 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'] 00:34:26 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 00:34:27 INFO - (blobuploader) - INFO - Open directory for files ... 00:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:27 INFO - (blobuploader) - INFO - Done attempting. 00:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:34:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:31 INFO - (blobuploader) - INFO - Done attempting. 00:34:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:34:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:34:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:34:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:34:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:34:32 INFO - (blobuploader) - INFO - Done attempting. 00:34:32 INFO - (blobuploader) - INFO - Iteration through files over. 00:34:32 INFO - Return code: 0 00:34:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:34:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:34:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a14a0cea2f791861b7b8f81e140888ab06fe0b356ebf12db66e6a07cfc18a0fae43ebfed7527f3b56355f3dcd30a49d1bc1fc3d7adf6e261dc68a827fda25c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6655e0ad26a8b5b4fb33ec870c8ae8c677cd3b636819c064c20a2ba377e12b341ba6e0ef24dd62c069b9ed3aad7089daa97b01e5a7b0893632c06e39e9132e72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259364ca11714c8d4eb58c4caeee71870b8f2bec433db200aa42cb068276967142f1f81ca06518514880fc151d4c185f7ca5521f72b282bd3d6a5bf488cd7909"} 00:34:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:34:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:34:32 INFO - Contents: 00:34:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a14a0cea2f791861b7b8f81e140888ab06fe0b356ebf12db66e6a07cfc18a0fae43ebfed7527f3b56355f3dcd30a49d1bc1fc3d7adf6e261dc68a827fda25c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6655e0ad26a8b5b4fb33ec870c8ae8c677cd3b636819c064c20a2ba377e12b341ba6e0ef24dd62c069b9ed3aad7089daa97b01e5a7b0893632c06e39e9132e72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259364ca11714c8d4eb58c4caeee71870b8f2bec433db200aa42cb068276967142f1f81ca06518514880fc151d4c185f7ca5521f72b282bd3d6a5bf488cd7909"} 00:34:32 INFO - Running post-run listener: copy_logs_to_upload_dir 00:34:32 INFO - Copying logs to upload dir... 00:34:32 INFO - mkdir: /builds/slave/test/build/upload/logs 00:34:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.391426 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 00:34:30.505653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 00:34:30.510533) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a14a0cea2f791861b7b8f81e140888ab06fe0b356ebf12db66e6a07cfc18a0fae43ebfed7527f3b56355f3dcd30a49d1bc1fc3d7adf6e261dc68a827fda25c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6655e0ad26a8b5b4fb33ec870c8ae8c677cd3b636819c064c20a2ba377e12b341ba6e0ef24dd62c069b9ed3aad7089daa97b01e5a7b0893632c06e39e9132e72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259364ca11714c8d4eb58c4caeee71870b8f2bec433db200aa42cb068276967142f1f81ca06518514880fc151d4c185f7ca5521f72b282bd3d6a5bf488cd7909"} build_url:https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/ACT7mxnXSuOxImHVWeVePQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96a14a0cea2f791861b7b8f81e140888ab06fe0b356ebf12db66e6a07cfc18a0fae43ebfed7527f3b56355f3dcd30a49d1bc1fc3d7adf6e261dc68a827fda25c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6655e0ad26a8b5b4fb33ec870c8ae8c677cd3b636819c064c20a2ba377e12b341ba6e0ef24dd62c069b9ed3aad7089daa97b01e5a7b0893632c06e39e9132e72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/259364ca11714c8d4eb58c4caeee71870b8f2bec433db200aa42cb068276967142f1f81ca06518514880fc151d4c185f7ca5521f72b282bd3d6a5bf488cd7909"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 00:34:30.539597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:34:30.540199) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1466664490.79063-1176366401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 00:34:30.624896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 00:34:30.625657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 00:34:30.626321) ========= ========= Total master_lag: 0.19 =========