builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1457723279.79 results: success (0) buildid: 20160311083214 builduid: 543fc6a9e86f460ab59aa905ae4a7fa9 revision: 90ff659e7fc8667df4ac453ce3f1f3cf597de548 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.791160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.791615) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.791906) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.813563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.813917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.827668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.828148) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.878087) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.878395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.878741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.879032) ========= 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 11:08:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.6M=0s 2016-03-11 11:08:00 (96.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.987697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:07:59.988007) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:08:00.037818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 11:08:00.038186) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 90ff659e7fc8667df4ac453ce3f1f3cf597de548 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 90ff659e7fc8667df4ac453ce3f1f3cf597de548 --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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 11:08:00,241 truncating revision to first 12 chars 2016-03-11 11:08:00,241 Setting DEBUG logging. 2016-03-11 11:08:00,242 attempt 1/10 2016-03-11 11:08:00,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/90ff659e7fc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 11:08:01,046 unpacking tar archive at: date-90ff659e7fc8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 11:08:01.147412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 11:08:01.147767) ========= echo 90ff659e7fc8667df4ac453ce3f1f3cf597de548 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'90ff659e7fc8667df4ac453ce3f1f3cf597de548'] 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 90ff659e7fc8667df4ac453ce3f1f3cf597de548 program finished with exit code 0 elapsedTime=0.004770 script_repo_revision: '90ff659e7fc8667df4ac453ce3f1f3cf597de548' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 11:08:01.198790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 11:08:01.199122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 11:08:01.209409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-11 11:08:01.209916) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-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', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:01 INFO - MultiFileLogger online at 20160311 11:08:01 in /builds/slave/test 11:08:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 11:08:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:01 INFO - {'append_to_log': False, 11:08:01 INFO - 'base_work_dir': '/builds/slave/test', 11:08:01 INFO - 'blob_upload_branch': 'Date-Non-PGO', 11:08:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:01 INFO - 'branch': 'Date-Non-PGO', 11:08:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:01 INFO - 'config_files': ('talos/linux_config.py',), 11:08:01 INFO - 'default_actions': ('clobber', 11:08:01 INFO - 'read-buildbot-config', 11:08:01 INFO - 'download-and-extract', 11:08:01 INFO - 'populate-webroot', 11:08:01 INFO - 'create-virtualenv', 11:08:01 INFO - 'install', 11:08:01 INFO - 'run-tests'), 11:08:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:01 INFO - 'download_minidump_stackwalk': True, 11:08:01 INFO - 'download_symbols': 'ondemand', 11:08:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:01 INFO - 'installer_path': 'installer.exe', 11:08:01 INFO - 'log_level': 'info', 11:08:01 INFO - 'log_name': 'talos', 11:08:01 INFO - 'log_to_console': True, 11:08:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:01 INFO - 'opt_config_files': (), 11:08:01 INFO - 'pip_index': False, 11:08:01 INFO - 'sps_profile': False, 11:08:01 INFO - 'sps_profile_interval': 0, 11:08:01 INFO - 'suite': 'dromaeojs', 11:08:01 INFO - 'system_bits': '32', 11:08:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:01 INFO - 'title': 'talos-linux64-ix-024', 11:08:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:01 INFO - 'use_talos_json': True, 11:08:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:01 INFO - 'work_dir': 'build'} 11:08:01 INFO - ##### 11:08:01 INFO - ##### Running clobber step. 11:08:01 INFO - ##### 11:08:01 INFO - Running pre-action listener: _resource_record_pre_action 11:08:01 INFO - Running main action method: clobber 11:08:01 INFO - rmtree: /builds/slave/test/build 11:08:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:01 INFO - Running post-action listener: _resource_record_post_action 11:08:01 INFO - ##### 11:08:01 INFO - ##### Running read-buildbot-config step. 11:08:01 INFO - ##### 11:08:01 INFO - Running pre-action listener: _resource_record_pre_action 11:08:01 INFO - Running main action method: read_buildbot_config 11:08:01 INFO - Using buildbot properties: 11:08:01 INFO - { 11:08:01 INFO - "project": "", 11:08:01 INFO - "product": "firefox", 11:08:01 INFO - "script_repo_revision": "production", 11:08:01 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 11:08:01 INFO - "repository": "", 11:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 11:08:01 INFO - "buildid": "20160311083214", 11:08:01 INFO - "pgo_build": "False", 11:08:01 INFO - "basedir": "/builds/slave/test", 11:08:01 INFO - "buildnumber": 4, 11:08:01 INFO - "slavename": "talos-linux64-ix-024", 11:08:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:08:01 INFO - "platform": "ubuntu64_hw", 11:08:01 INFO - "scheduler": "tests-date-linux64-talos", 11:08:01 INFO - "branch": "date", 11:08:01 INFO - "repo_path": "projects/date", 11:08:01 INFO - "revision": "90ff659e7fc8667df4ac453ce3f1f3cf597de548", 11:08:01 INFO - "stage_platform": "linux64", 11:08:01 INFO - "builduid": "543fc6a9e86f460ab59aa905ae4a7fa9", 11:08:01 INFO - "slavebuilddir": "test" 11:08:01 INFO - } 11:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 11:08:01 INFO - Running post-action listener: _resource_record_post_action 11:08:01 INFO - ##### 11:08:01 INFO - ##### Running download-and-extract step. 11:08:01 INFO - ##### 11:08:01 INFO - Running pre-action listener: _resource_record_pre_action 11:08:01 INFO - Running main action method: download_and_extract 11:08:01 INFO - mkdir: /builds/slave/test/build/tests 11:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:01 INFO - https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/test_packages.json 11:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/test_packages.json 11:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:08:06 INFO - Downloaded 1412 bytes. 11:08:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:08:06 INFO - Using the following test package requirements: 11:08:06 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 11:08:06 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:06 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 11:08:06 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'jsshell-linux-x86_64.zip'], 11:08:06 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:06 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 11:08:06 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 11:08:06 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 11:08:06 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:06 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 11:08:06 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 11:08:06 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:06 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08: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')]} 11:08:06 INFO - https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:08:10 INFO - Downloaded 23091331 bytes. 11:08:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:08:11 INFO - Return code: 0 11:08:11 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:08: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')]} 11:08:11 INFO - https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 11:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:08:13 INFO - Downloaded 23091331 bytes. 11:08:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:08:15 INFO - Return code: 0 11:08:15 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')]} 11:08:15 INFO - https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 11:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 11:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 11:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:08:16 INFO - Downloaded 10706668 bytes. 11:08:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:08:16 INFO - Return code: 0 11:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:16 INFO - https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 11:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 11:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 11:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:08:17 INFO - Downloaded 52859566 bytes. 11:08:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 11:08:17 INFO - mkdir: /builds/slave/test/properties 11:08:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:17 INFO - Contents: 11:08:17 INFO - build_url:https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 11:08:18 INFO - Running post-action listener: _resource_record_post_action 11:08:18 INFO - Running post-action listener: set_extra_try_arguments 11:08:18 INFO - ##### 11:08:18 INFO - ##### Running populate-webroot step. 11:08:18 INFO - ##### 11:08:18 INFO - Running pre-action listener: _resource_record_pre_action 11:08:18 INFO - Running main action method: populate_webroot 11:08:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:18 INFO - '--tppagecycles', 11:08:18 INFO - '7'], 11:08:18 INFO - 'tests': ['tsvgm']}}, 11:08:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:08:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:08:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:08:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'tests': ['damp', 'tps']}, 11:08:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['damp', 'tps']}, 11:08:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:08:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:18 INFO - 'other': {'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'other_l64': {'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'other_nol64': {'tests': ['a11yr', 11:08:18 INFO - 'ts_paint', 11:08:18 INFO - 'tpaint', 11:08:18 INFO - 'sessionrestore', 11:08:18 INFO - 'sessionrestore_no_auto_restore']}, 11:08:18 INFO - 'svgr': {'tests': ['tsvgx', 11:08:18 INFO - 'tsvgr_opacity', 11:08:18 INFO - 'tart', 11:08:18 INFO - 'tscrollx', 11:08:18 INFO - 'cart']}, 11:08:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['tsvgx', 11:08:18 INFO - 'tsvgr_opacity', 11:08:18 INFO - 'tart', 11:08:18 INFO - 'tscrollx', 11:08:18 INFO - 'cart']}, 11:08:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'tests': ['tp5o']}, 11:08:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'talos_options': ['--e10s'], 11:08:18 INFO - 'tests': ['tp5o']}, 11:08:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'talos_options': ['--xperf_path', 11:08:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:18 INFO - 'tests': ['tp5n']}, 11:08:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:18 INFO - 'talos_options': ['--e10s', 11:08:18 INFO - '--xperf_path', 11:08:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:18 INFO - 'tests': ['tp5n']}}, 11:08:18 INFO - 'talos.zip': {'path': '', 11:08:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:18 INFO - Running post-action listener: _resource_record_post_action 11:08:18 INFO - ##### 11:08:18 INFO - ##### Running create-virtualenv step. 11:08:18 INFO - ##### 11:08:18 INFO - Running pre-action listener: _resource_record_pre_action 11:08:18 INFO - Running main action method: create_virtualenv 11:08:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:18 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 11:08:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:18 INFO - Using real prefix '/usr' 11:08:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:20 INFO - Installing pip.................done. 11:08:20 INFO - Return code: 0 11:08:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:20 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')]} 11:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:20 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')]} 11:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:20 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:20 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 11:08:20 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 11:08:20 INFO - Using env: {'DISPLAY': ':0', 11:08:20 INFO - 'HOME': '/home/cltbld', 11:08:20 INFO - 'LANG': 'en_US.UTF-8', 11:08:20 INFO - 'LANGUAGE': 'en_US:en', 11:08:20 INFO - 'LOGNAME': 'cltbld', 11:08:20 INFO - 'MAIL': '/var/mail/cltbld', 11:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:20 INFO - 'MOZ_NO_REMOTE': '1', 11:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:20 INFO - 'NO_EM_RESTART': '1', 11:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:20 INFO - 'PWD': '/builds/slave/test', 11:08:20 INFO - 'SHELL': '/bin/bash', 11:08:20 INFO - 'SHLVL': '1', 11:08:20 INFO - 'TERM': 'linux', 11:08:20 INFO - 'TMOUT': '86400', 11:08:20 INFO - 'USER': 'cltbld', 11:08:20 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:20 INFO - '_': '/tools/buildbot/bin/python'} 11:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:21 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 11:08:21 INFO - Cleaning up... 11:08:21 INFO - Return code: 0 11:08:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:08:21 INFO - Using env: {'DISPLAY': ':0', 11:08:21 INFO - 'HOME': '/home/cltbld', 11:08:21 INFO - 'LANG': 'en_US.UTF-8', 11:08:21 INFO - 'LANGUAGE': 'en_US:en', 11:08:21 INFO - 'LOGNAME': 'cltbld', 11:08:21 INFO - 'MAIL': '/var/mail/cltbld', 11:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:21 INFO - 'MOZ_NO_REMOTE': '1', 11:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:21 INFO - 'NO_EM_RESTART': '1', 11:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:21 INFO - 'PWD': '/builds/slave/test', 11:08:21 INFO - 'SHELL': '/bin/bash', 11:08:21 INFO - 'SHLVL': '1', 11:08:21 INFO - 'TERM': 'linux', 11:08:21 INFO - 'TMOUT': '86400', 11:08:21 INFO - 'USER': 'cltbld', 11:08:21 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:21 INFO - '_': '/tools/buildbot/bin/python'} 11:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:21 INFO - Downloading/unpacking psutil>=0.7.1 11:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:23 INFO - Installing collected packages: psutil 11:08:23 INFO - Running setup.py install for psutil 11:08:23 INFO - building 'psutil._psutil_linux' extension 11:08:23 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 11:08:23 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 11:08:23 INFO - building 'psutil._psutil_posix' extension 11:08:23 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 11:08:23 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 11:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:23 INFO - Successfully installed psutil 11:08:23 INFO - Cleaning up... 11:08:24 INFO - Return code: 0 11:08:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:08:24 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')]} 11:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 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')]} 11:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:08:24 INFO - Using env: {'DISPLAY': ':0', 11:08:24 INFO - 'HOME': '/home/cltbld', 11:08:24 INFO - 'LANG': 'en_US.UTF-8', 11:08:24 INFO - 'LANGUAGE': 'en_US:en', 11:08:24 INFO - 'LOGNAME': 'cltbld', 11:08:24 INFO - 'MAIL': '/var/mail/cltbld', 11:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:24 INFO - 'MOZ_NO_REMOTE': '1', 11:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:24 INFO - 'NO_EM_RESTART': '1', 11:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:24 INFO - 'PWD': '/builds/slave/test', 11:08:24 INFO - 'SHELL': '/bin/bash', 11:08:24 INFO - 'SHLVL': '1', 11:08:24 INFO - 'TERM': 'linux', 11:08:24 INFO - 'TMOUT': '86400', 11:08:24 INFO - 'USER': 'cltbld', 11:08:24 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:24 INFO - '_': '/tools/buildbot/bin/python'} 11:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:08:26 INFO - Installing collected packages: mozsystemmonitor 11:08:26 INFO - Running setup.py install for mozsystemmonitor 11:08:26 INFO - Successfully installed mozsystemmonitor 11:08:26 INFO - Cleaning up... 11:08:26 INFO - Return code: 0 11:08:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:26 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:26 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 11:08:26 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 11:08:26 INFO - Using env: {'DISPLAY': ':0', 11:08:26 INFO - 'HOME': '/home/cltbld', 11:08:26 INFO - 'LANG': 'en_US.UTF-8', 11:08:26 INFO - 'LANGUAGE': 'en_US:en', 11:08:26 INFO - 'LOGNAME': 'cltbld', 11:08:26 INFO - 'MAIL': '/var/mail/cltbld', 11:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:26 INFO - 'MOZ_NO_REMOTE': '1', 11:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:26 INFO - 'NO_EM_RESTART': '1', 11:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:26 INFO - 'PWD': '/builds/slave/test', 11:08:26 INFO - 'SHELL': '/bin/bash', 11:08:26 INFO - 'SHLVL': '1', 11:08:26 INFO - 'TERM': 'linux', 11:08:26 INFO - 'TMOUT': '86400', 11:08:26 INFO - 'USER': 'cltbld', 11:08:26 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:26 INFO - '_': '/tools/buildbot/bin/python'} 11:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:26 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 11:08:26 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 11:08:26 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 11:08:26 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 11:08:26 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 11:08:26 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 11:08:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 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 11:08:28 INFO - Downloading docopt-0.6.1.tar.gz 11:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:29 INFO - Running setup.py install for blobuploader 11:08:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:29 INFO - Running setup.py install for requests 11:08:29 INFO - Running setup.py install for docopt 11:08:29 INFO - Successfully installed blobuploader requests docopt 11:08:29 INFO - Cleaning up... 11:08:29 INFO - Return code: 0 11:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:29 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:29 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 11:08:29 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 11:08:29 INFO - Using env: {'DISPLAY': ':0', 11:08:29 INFO - 'HOME': '/home/cltbld', 11:08:29 INFO - 'LANG': 'en_US.UTF-8', 11:08:29 INFO - 'LANGUAGE': 'en_US:en', 11:08:29 INFO - 'LOGNAME': 'cltbld', 11:08:29 INFO - 'MAIL': '/var/mail/cltbld', 11:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:29 INFO - 'MOZ_NO_REMOTE': '1', 11:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:29 INFO - 'NO_EM_RESTART': '1', 11:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:29 INFO - 'PWD': '/builds/slave/test', 11:08:29 INFO - 'SHELL': '/bin/bash', 11:08:29 INFO - 'SHLVL': '1', 11:08:29 INFO - 'TERM': 'linux', 11:08:29 INFO - 'TMOUT': '86400', 11:08:29 INFO - 'USER': 'cltbld', 11:08:29 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:29 INFO - '_': '/tools/buildbot/bin/python'} 11:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:29 INFO - Running setup.py (path:/tmp/pip-QrAvuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:29 INFO - Running setup.py (path:/tmp/pip-mZPwJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:29 INFO - Running setup.py (path:/tmp/pip-qXxqVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:30 INFO - Running setup.py (path:/tmp/pip-2pjvAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:30 INFO - Running setup.py (path:/tmp/pip-JhnytE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:30 INFO - Running setup.py (path:/tmp/pip-_AtvyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:30 INFO - Running setup.py (path:/tmp/pip-2mw976-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:30 INFO - Running setup.py (path:/tmp/pip-3jomzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:30 INFO - Running setup.py (path:/tmp/pip-qd9YcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:30 INFO - Running setup.py (path:/tmp/pip-V1kwxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:30 INFO - Running setup.py (path:/tmp/pip-Cc8k7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:30 INFO - Running setup.py (path:/tmp/pip-Zk6KQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:30 INFO - Running setup.py (path:/tmp/pip-Dj_O6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:30 INFO - Running setup.py (path:/tmp/pip-Xvcfu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:30 INFO - Running setup.py (path:/tmp/pip-mBvssX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:30 INFO - Running setup.py (path:/tmp/pip-C6AsMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:30 INFO - Running setup.py (path:/tmp/pip-vyn8Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:31 INFO - Running setup.py install for manifestparser 11:08:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozcrash 11:08:31 INFO - Running setup.py install for mozdebug 11:08:31 INFO - Running setup.py install for mozdevice 11:08:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozfile 11:08:31 INFO - Running setup.py install for mozhttpd 11:08:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozinfo 11:08:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozInstall 11:08:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozleak 11:08:31 INFO - Running setup.py install for mozlog 11:08:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for moznetwork 11:08:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozprocess 11:08:32 INFO - Running setup.py install for mozprofile 11:08:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozrunner 11:08:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozscreenshot 11:08:32 INFO - Running setup.py install for moztest 11:08:32 INFO - Running setup.py install for mozversion 11:08:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:32 INFO - Cleaning up... 11:08:32 INFO - Return code: 0 11:08:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:32 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:32 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 11:08:32 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 11:08:32 INFO - Using env: {'DISPLAY': ':0', 11:08:32 INFO - 'HOME': '/home/cltbld', 11:08:32 INFO - 'LANG': 'en_US.UTF-8', 11:08:32 INFO - 'LANGUAGE': 'en_US:en', 11:08:32 INFO - 'LOGNAME': 'cltbld', 11:08:32 INFO - 'MAIL': '/var/mail/cltbld', 11:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:32 INFO - 'MOZ_NO_REMOTE': '1', 11:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:32 INFO - 'NO_EM_RESTART': '1', 11:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:32 INFO - 'PWD': '/builds/slave/test', 11:08:32 INFO - 'SHELL': '/bin/bash', 11:08:32 INFO - 'SHLVL': '1', 11:08:32 INFO - 'TERM': 'linux', 11:08:32 INFO - 'TMOUT': '86400', 11:08:32 INFO - 'USER': 'cltbld', 11:08:32 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:32 INFO - '_': '/tools/buildbot/bin/python'} 11:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:33 INFO - Running setup.py (path:/tmp/pip-ynBHX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:33 INFO - Running setup.py (path:/tmp/pip-FF0_Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:33 INFO - Running setup.py (path:/tmp/pip-OyYGlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:33 INFO - Running setup.py (path:/tmp/pip-wEPYhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:33 INFO - Running setup.py (path:/tmp/pip-4BmVhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:33 INFO - Running setup.py (path:/tmp/pip-0UrBOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:33 INFO - Running setup.py (path:/tmp/pip-RpwW4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:33 INFO - Running setup.py (path:/tmp/pip-HDU6VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:33 INFO - Running setup.py (path:/tmp/pip-LAbtdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:33 INFO - Running setup.py (path:/tmp/pip-bvh2U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:33 INFO - Running setup.py (path:/tmp/pip-iLbwvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:33 INFO - Running setup.py (path:/tmp/pip-KMQ0Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:33 INFO - Running setup.py (path:/tmp/pip-hQ0hOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:34 INFO - Running setup.py (path:/tmp/pip-3y2kuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:34 INFO - Running setup.py (path:/tmp/pip-gryujL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:34 INFO - Running setup.py (path:/tmp/pip-HHObrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:34 INFO - Running setup.py (path:/tmp/pip-DyL9ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:34 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)) 11:08:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:34 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)) 11:08:34 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)) 11:08:34 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)) 11:08:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:36 INFO - Downloading blessings-1.6.tar.gz 11:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:36 INFO - Installing collected packages: blessings 11:08:36 INFO - Running setup.py install for blessings 11:08:36 INFO - Successfully installed blessings 11:08:36 INFO - Cleaning up... 11:08:36 INFO - Return code: 0 11:08:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:36 INFO - Reading from file tmpfile_stdout 11:08:36 INFO - Current package versions: 11:08:36 INFO - argparse == 1.2.1 11:08:36 INFO - blessings == 1.6 11:08:36 INFO - blobuploader == 1.2.4 11:08:36 INFO - docopt == 0.6.1 11:08:36 INFO - manifestparser == 1.1 11:08:36 INFO - mozInstall == 1.12 11:08:36 INFO - mozcrash == 0.16 11:08:36 INFO - mozdebug == 0.1 11:08:36 INFO - mozdevice == 0.48 11:08:36 INFO - mozfile == 1.2 11:08:36 INFO - mozhttpd == 0.7 11:08:36 INFO - mozinfo == 0.9 11:08:36 INFO - mozleak == 0.1 11:08:36 INFO - mozlog == 3.1 11:08:36 INFO - moznetwork == 0.27 11:08:36 INFO - mozprocess == 0.22 11:08:36 INFO - mozprofile == 0.28 11:08:36 INFO - mozrunner == 6.11 11:08:36 INFO - mozscreenshot == 0.1 11:08:36 INFO - mozsystemmonitor == 0.0 11:08:36 INFO - moztest == 0.7 11:08:36 INFO - mozversion == 1.4 11:08:36 INFO - psutil == 3.1.1 11:08:36 INFO - requests == 1.2.3 11:08:36 INFO - wsgiref == 0.1.2 11:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:36 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 11:08:36 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 11:08:36 INFO - Using env: {'DISPLAY': ':0', 11:08:36 INFO - 'HOME': '/home/cltbld', 11:08:36 INFO - 'LANG': 'en_US.UTF-8', 11:08:36 INFO - 'LANGUAGE': 'en_US:en', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MAIL': '/var/mail/cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SHLVL': '1', 11:08:36 INFO - 'TERM': 'linux', 11:08:36 INFO - 'TMOUT': '86400', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - '_': '/tools/buildbot/bin/python'} 11:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 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)) 11:08:36 INFO - Cleaning up... 11:08:36 INFO - Return code: 0 11:08:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:36 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 11:08:36 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 11:08:36 INFO - Using env: {'DISPLAY': ':0', 11:08:36 INFO - 'HOME': '/home/cltbld', 11:08:36 INFO - 'LANG': 'en_US.UTF-8', 11:08:36 INFO - 'LANGUAGE': 'en_US:en', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MAIL': '/var/mail/cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SHLVL': '1', 11:08:36 INFO - 'TERM': 'linux', 11:08:36 INFO - 'TMOUT': '86400', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - '_': '/tools/buildbot/bin/python'} 11:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:37 INFO - Downloading/unpacking jsonschema 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:38 INFO - Downloading/unpacking functools32 (from jsonschema) 11:08:38 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 11:08:38 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 11:08:38 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 11:08:38 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 11:08:38 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 11:08:38 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 11:08:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:39 INFO - warning: no files found matching '*.txt' 11:08:39 INFO - no previously-included directories found matching 'build' 11:08:39 INFO - no previously-included directories found matching 'dist' 11:08:39 INFO - no previously-included directories found matching '.git*' 11:08:39 INFO - Installing collected packages: jsonschema, functools32 11:08:39 INFO - Running setup.py install for functools32 11:08:39 INFO - warning: no files found matching '*.txt' 11:08:39 INFO - no previously-included directories found matching 'build' 11:08:39 INFO - no previously-included directories found matching 'dist' 11:08:39 INFO - no previously-included directories found matching '.git*' 11:08:39 INFO - Successfully installed jsonschema functools32 11:08:39 INFO - Cleaning up... 11:08:39 INFO - Return code: 0 11:08:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:08:39 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')]} 11:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:39 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')]} 11:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:39 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 0x7f9ad2828f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ede30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, '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': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', '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 11:08:39 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 11:08:39 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 11:08:39 INFO - Using env: {'DISPLAY': ':0', 11:08:39 INFO - 'HOME': '/home/cltbld', 11:08:39 INFO - 'LANG': 'en_US.UTF-8', 11:08:39 INFO - 'LANGUAGE': 'en_US:en', 11:08:39 INFO - 'LOGNAME': 'cltbld', 11:08:39 INFO - 'MAIL': '/var/mail/cltbld', 11:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:39 INFO - 'MOZ_NO_REMOTE': '1', 11:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:39 INFO - 'NO_EM_RESTART': '1', 11:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:39 INFO - 'PWD': '/builds/slave/test', 11:08:39 INFO - 'SHELL': '/bin/bash', 11:08:39 INFO - 'SHLVL': '1', 11:08:39 INFO - 'TERM': 'linux', 11:08:39 INFO - 'TMOUT': '86400', 11:08:39 INFO - 'USER': 'cltbld', 11:08:39 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:39 INFO - '_': '/tools/buildbot/bin/python'} 11:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:39 INFO - Downloading/unpacking flake8 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:42 INFO - no previously-included directories found matching 'docs/_build' 11:08:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:42 INFO - Running setup.py install for pep8 11:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:42 INFO - no previously-included directories found matching 'docs/_build' 11:08:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:08:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:42 INFO - Cleaning up... 11:08:42 INFO - Return code: 0 11:08:42 INFO - Running post-action listener: _resource_record_post_action 11:08:42 INFO - Running post-action listener: _start_resource_monitoring 11:08:42 INFO - Starting resource monitoring. 11:08:42 INFO - ##### 11:08:42 INFO - ##### Running install step. 11:08:42 INFO - ##### 11:08:42 INFO - Running pre-action listener: _resource_record_pre_action 11:08:42 INFO - Running main action method: install 11:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:42 INFO - Reading from file tmpfile_stdout 11:08:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:42 INFO - Reading from file tmpfile_stdout 11:08:42 INFO - Output received: 11:08:42 INFO - Usage: mozinstall [options] installer 11:08:42 INFO - Options: 11:08:42 INFO - -h, --help show this help message and exit 11:08:42 INFO - -d DEST, --destination=DEST 11:08:42 INFO - Directory to install application into. [default: 11:08:42 INFO - "/builds/slave/test"] 11:08:42 INFO - --app=APP Application being installed. [default: firefox] 11:08:42 INFO - mkdir: /builds/slave/test/build/application 11:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:55 INFO - Reading from file tmpfile_stdout 11:08:55 INFO - Output received: 11:08:55 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:55 INFO - Running post-action listener: _resource_record_post_action 11:08:55 INFO - ##### 11:08:55 INFO - ##### Running run-tests step. 11:08:55 INFO - ##### 11:08:55 INFO - Running pre-action listener: _resource_record_pre_action 11:08:55 INFO - Running main action method: run_tests 11:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:55 INFO - Python 2.7.3 11:08:55 INFO - Return code: 0 11:08:55 INFO - grabbing minidump binary from tooltool 11:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2980430>, '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 0x28ebf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ec3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:55 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 11:08:55 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 11:08:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:55 INFO - Return code: 0 11:08:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:08:56 INFO - Return code: 0 11:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 11:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 11:08:56 INFO - Using env: {'DISPLAY': ':0', 11:08:56 INFO - 'HOME': '/home/cltbld', 11:08:56 INFO - 'LANG': 'en_US.UTF-8', 11:08:56 INFO - 'LANGUAGE': 'en_US:en', 11:08:56 INFO - 'LOGNAME': 'cltbld', 11:08:56 INFO - 'MAIL': '/var/mail/cltbld', 11:08:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:56 INFO - 'MOZ_NO_REMOTE': '1', 11:08:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:56 INFO - 'NO_EM_RESTART': '1', 11:08:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:56 INFO - 'PWD': '/builds/slave/test', 11:08:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:56 INFO - 'SHELL': '/bin/bash', 11:08:56 INFO - 'SHLVL': '1', 11:08:56 INFO - 'TERM': 'linux', 11:08:56 INFO - 'TMOUT': '86400', 11:08:56 INFO - 'USER': 'cltbld', 11:08:56 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814', 11:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:56 INFO - '_': '/tools/buildbot/bin/python'} 11:08:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 11:08:56 INFO - mozversion application_buildid: 20160311083214 11:08:56 INFO - mozversion application_changeset: 90ff659e7fc8667df4ac453ce3f1f3cf597de548 11:08:56 INFO - mozversion application_display_name: Firefox 11:08:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:56 INFO - mozversion application_name: Firefox 11:08:56 INFO - mozversion application_remotingname: firefox 11:08:56 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 11:08:56 INFO - mozversion application_vendor: Mozilla 11:08:56 INFO - mozversion application_version: 46.0 11:08:56 INFO - mozversion platform_buildid: 20160311083214 11:08:56 INFO - mozversion platform_changeset: 90ff659e7fc8667df4ac453ce3f1f3cf597de548 11:08:56 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 11:08:56 INFO - mozversion platform_version: 46.0 11:08:56 INFO - using testdate: 1457723336 11:08:56 INFO - actual date: 1457723336 11:08:56 INFO - starting webserver on 'localhost:48122' 11:08:56 INFO - SUITE-START | Running 3 tests 11:08:56 INFO - TEST-START | dromaeo_css 11:08:56 INFO - operating with platform_type : linux_ 11:08:56 INFO - Initialising browser for dromaeo_css test... 11:08:56 INFO - TEST-INFO | started process 3724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprffgkS/profile http://localhost:48122/getInfo.html) 11:09:00 INFO - PROCESS | 3724 | __metrics Screen width/height:1600/1200 11:09:00 INFO - PROCESS | 3724 | colorDepth:24 11:09:00 INFO - PROCESS | 3724 | Browser inner width/height: 1024/697 11:09:00 INFO - PROCESS | 3724 | __metrics 11:09:00 INFO - PROCESS | 3724 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:01 INFO - TEST-INFO | 3724: exit 0 11:09:01 INFO - Browser initialized. 11:09:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:01 INFO - TEST-INFO | started process 3813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprffgkS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:13 INFO - PROCESS | 3813 | RSS: Main: 135376896 11:09:13 INFO - PROCESS | 3813 | 11:10:04 INFO - PROCESS | 3813 | 1457723404107 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] 11:12:12 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48122/tests/dromaeo/cssquery-ext.html) 11:12:12 INFO - PROCESS | 3813 | RSS: Main: 222273536 11:12:12 INFO - PROCESS | 3813 | 11:15:14 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-ext.html (next: http://localhost:48122/tests/dromaeo/cssquery-jquery.html) 11:15:15 INFO - PROCESS | 3813 | RSS: Main: 213909504 11:15:15 INFO - PROCESS | 3813 | 11:18:17 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48122/tests/dromaeo/cssquery-mootools.html) 11:18:17 INFO - PROCESS | 3813 | RSS: Main: 213430272 11:18:17 INFO - PROCESS | 3813 | 11:21:19 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48122/tests/dromaeo/cssquery-prototype.html) 11:21:20 INFO - PROCESS | 3813 | RSS: Main: 202178560 11:21:20 INFO - PROCESS | 3813 | 11:24:22 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48122/tests/dromaeo/cssquery-yui.html) 11:24:23 INFO - PROCESS | 3813 | RSS: Main: 200540160 11:24:23 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:48122/tests/dromaeo/cssquery-yui.html (next: http://localhost:48122/tests/dromaeo/cssquery-dojo.html) 11:27:25 INFO - PROCESS | 3813 | RSS: Main: 245854208 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | __start_tp_report 11:27:25 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 11:27:25 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 11:27:25 INFO - PROCESS | 3813 | |i|pagename|runs| 11:27:25 INFO - PROCESS | 3813 | |0;dojo.html;3228.1122691259907;3302.504624306352;3315.535824984504;3326.101952472832;3357.999999999999;5327.254184414185;5334.333208348957;5335.173048177529;5353.866153346168;5359.758810853511;5333.173358129496;5348.197770334452;5359.812406565771;5360.035193665139;5372.57019438445;4809.302651115586;4893.339399181101;4895.951040489603;4904.509549045102;4944.678595891273;4861.027794441108;4869.050535145648;4934.161192597249;4940.086084074458;4941.851744447672;4844.806207751686;4922.138625740499;4925.950740492603;5012.198048312271;5013.5989120870245;4913.533214344631;4917.631177661672;4939.777710003059;4941.308216849626;4973.3286006389035;4771.308160316769;4857.53853383928;4866.416030076413;4882.218844984785;4922.630802689777;5127.48725127488;5206.505381988705;5217.191335343028;5224.190250511177;5224.843254702365;5658.575606829504;5700.144978253254;5705.62913410627;5705.800296989627;5710.771569137271;5682.289713785777;5691.459311365414;5706.400827913051;5738.311402631669;5787.942120578782;5451.073317536028;5479.698616576086;5482.616216864821;5483.424240454775;5485.040117979377;5916.645001299936;5917.911231331447;5918.467337939606;5924.081767326072;5925.318588362307;5547.278853749068;5651.858703532444;5662.518685911744;5730.36965933747;5741.770329186869;5740.942590574041;5747.827565173052;5755.280589926259;5760.42395760429;5786.768529258867;5720.027595308808;5721.5708821838525;5723.170140329629;5731.914021289684;5734.168545560954;5544.750486228129;5645.5201307888465;5694.9430505695245;5711.457411545896;5791.768329266866;4434.911301773946;4445.044315472124;4453.621442177451;4459.598636122764;4480.820767169342;4023.6781057515327;4024.7987600619854;4028.295048366524;4061.248668996186;4065.1259979104634;5327.786888524493;5368.248445217672;5374.140137577969;5453.509184173444;5459.645123066988;5723.427657234243;5725.08398656213;5733.426657334233;5733.483986441241;5742.626729262584;5420.539254163361;5420.810271640474;5423.755930983115;5430.456954304538;5436.809711660152;4928;4985.725785081855;4990.17662085759;5010.574101201366;5084.906745049758;5879.059350503984;5896.410358964069;5914.497267732291;5917.142014407973;5918.348981612019;5742.827715168552;5766.394528574607;5770.596058275881;5773.3072031356505;5775.451332123442;5697.857553561194;5779.768809247751;5804.042333015174;5863.973804584266;5894.587378883437;5749.741261643152;5759.481646651654;5768;5781.566382521243;5790.710464476843;5633.746481408429;5789.739461724317;5846.853828654318;5869.325027621878;5874.060150375919;5566.91649625264;5624.634398764068;5637.267155269788;5638.097904335286;5662.320521537277;5601.663900166003;5668.518175954925;5671.432856714296;5673.943260567342;5680.857978550569;5425;5515.58633102527;5519.227308176939;5534.972325138348;5535.833924982257;5622.32532096151;5644.6613203207935;5668.971655141698;5673.205751194919;5721.8569535761935;5459.372172200247;5480.314960629921;5512.228288039758;5513.2005859151;5513.889722205614 11:27:25 INFO - PROCESS | 3813 | |1;ext.html;527.42247239273;529.3568314497884;551.1842473139753;577.3995045153041;590.9982579527702;29855.701442985563;35634;35671.821640891794;35713.82143089284;35775.4633680495;41410.37884431736;42080.15839683205;42141.57858421415;42172.578274217245;42211.57788422115;8771.868421973692;8975.461472311683;8983.820323593523;8983.865242021375;8985.730428087169;8658.350623703247;8726.171013753683;8748.956255218714;8756.649734010633;8788.912110878906;8776.297896168291;9065.501397423139;9083.772905677344;9090.045545217723;9120;8865.379423440361;9028.052054534277;9032.187103160748;9032.8645070324;9037.502937338444;8888.822223555557;9005.684801031932;9031.412958157764;9035.18683318498;9036;42362.364564531556;42665.786671066446;42889.78555107236;42899.57100428987;42941.785291073655;3710.499082623838;3770.604086570898;3872.883813485572;4216.64158546524;4225.197212529641;30799.846000770078;32990.17524561881;33142.6685733142;33252.50121248183;33264.6673533264;3940.6059394060653;4042.8239874223195;4076.470058892325;4098.561111582469;4098.6516146127315;295276;297240;297855;298052;298093;57803.421965780646;58927;66488;66490.33509664841;66747.33252667412;60171.39828601658;60228.39771602228;60394;60549.39450605526;60634.69682651559;15587.454439094805;15589.376424942875;15687.843121568867;15695.68608627821;15720.135392553291;13363.198208107544;13468.191908485522;13477.932610337082;13612.31938403076;13616.18302901829;21826.672599911013;22363.329100127023;22392.10431582751;22456.775432245468;22584.66123008156;7279.1265048194555;7424.814379640552;7571;7604.163542010375;7626.771196864103;1010.3887148275335;1010.6513252927729;1030.4590090202553;1103.315944114654;1107.3189988157226;26240.73759262383;26560.203193904214;26721.86639066831;27578.862105689743;32763;1111.6164923101517;1133.3766428464476;1145.1869172887177;1237.8762123787549;1260.3383223807575;13793.24137172445;15536.533903982898;16202.918985404998;16355.509334719978;16367.508974730777;312520;321332;322589;322792;323573;53954.46045539495;54422;54451.72774136183;54556.45443545593;54576;1298.2664794391328;1487.4868170481166;1507.366905899525;1514.6440586462172;1522.0259034218109;24634.384140396633;28827.279318017216;30205;30344;30914.845425772728;54105.72947135397;54897.725511372184;54934.72532637311;55041.72479137579;55105;316224;317327;317986;319251;319311;30336.089917302517;30765;34301.31397371989;34479.827600861834;35792.46311305281;39532;39610.80194599008;39628.60371396249;40678.1864362717;40783.388249175696;37458.81270593739;37459.62540374562;37656.623433765315;37663.246735065695;38634.42048369221;37568.060798480255;38066.80966595149;38246.23507529778;38496.422553662276;40851;34975.300493990486;35711;35769;35954.82022589975;35967.460488093224;31083;32358.19104522406;33160;33216;33368.833155834065;23650;24008.87995560011;24272.514549708554;25028.124015659363;25078.62382064234 11:27:25 INFO - PROCESS | 3813 | |2;jquery.html;364.9580298265699;368.101831531064;370.39440514758377;371.11859334081555;379.23583978283745;14100.153990760562;15787.684246315066;16407.835921640795;17504.124793760308;18181.909090454545;10728.356298622088;11226.550937962493;11380.487878045487;11473.942630286836;11482.368469734161;3807.7715337079726;4879.658423910328;5018.121828679967;5019.673721208128;5020.046191223656;3913.2956067907767;5237.397699264595;5421.159720243349;5422.322209723785;5427.83716488504;5376.865578360553;5381.273528073719;5564.415736347686;5938.376470470603;5973.074173503114;5536.944630553683;5957.761689532414;5977.22296101504;6004.42957918997;6008.579399442019;5383.488568585978;5395.919061214085;5396.10964190908;5397.460253974571;5401.567874570025;12729.936350318281;17473.47579572615;20021.299254526166;20591.485212869797;20736.274230401865;2155.75208850981;2223.566404551113;2249.347689170139;2262.9773702262933;2270.4891399434996;9622.182114520205;9671.661491847823;11435.256708313933;13174.914722642521;13404.396802143927;1738.3220543987854;1803.8286362795513;1985.7815640279557;2009.6282187795305;2039.3983774786473;54759.726201369136;54955;55686.44313556853;56645.15032274519;56896;10096.949515252523;10105.898941010642;10126.645567405252;10185.9490702546;10186.847197292047;12709.93645031769;12743.617691469271;12836;12871.099023068482;12881;8062.596870156469;8085.555294458862;8101.837963240702;8131.349492040623;8143.470674406145;8032.879506807402;8074.919250807417;8117.107118216992;8117.107118216992;8139.348852091818;4316.762578058174;4328.9134217316105;4418.8453404130705;4440.267355886307;4478.641708663299;1739.7738294021697;1764.4001039646582;1783.8216178382318;1808.6563552924902;1812.9546761330807;936.9156775890202;957.5499515227832;970.669972209438;1049.6588608702202;1119.8096323625002;16294;16635.91682041582;17151.228194731266;17552.122393880254;18329.81670183308;979.8628192052976;1029.325791606499;1040.843873418993;1075.1291453922347;1096.331237944853;9575.712728618153;9958.601655933682;10065.496725163712;10070.899291006996;10080;518814;519849;523101;556211;560558;67901;79455;79965;80705;82341.58829205815;1223.0215827337915;1226.4419689041465;1230.3233221728015;1246.9300960405865;1273.2869593027933;15076.773848392064;15082.24588770579;15125.621859453602;15131.167785771888;15480.690386192438;34017;34803.82598086994;35387.646123538434;35620.46569301515;36475.27049458943;44812.32781508215;45045.32432013588;45639.31541026953;46153.538464614925;47015.52984470248;7548.849023019399;7647.847043058996;7696.846063078595;7725.459217854696;7793.766187014398;8139.674413023413;9609.51952402391;10756.838647420138;10859.945700271448;11381.715457113638;9719.222462202866;9889.554970026222;10097.798044039226;10146.340487868265;10218.795624087625;9582;9754.463504507037;9825.4104753715;10047.497625118862;10296.588136474757;7268.745593904188;9962.302638815503;10155.695329140137;10572.788544228919;10772.407517586607;7945.165757595601;7988.360931125612;8029.397795165269;8044.517328960281;8079.151689072798;10303.3817970922;10482.109020733018;10688.038076573146;10740.785184296426;10753.408562528823 11:27:25 INFO - PROCESS | 3813 | |3;mootools.html;1502.3314624991879;1504.7141043201793;1690.4759524547392;1815.0289595066643;1845.0774612693654;8277.337812974962;8536.829263414736;8540.060593334729;8550.444221125637;8561.65753369866;8266.049404318504;8382.413231073828;8398.748037558884;8433.524133276667;8448.78878028048;2449.448874003344;2506.29823649378;2522.823402361835;2528.190978886757;2530.6710127683377;2518.055729101587;2543.78377837884;2558.9744102559016;2560.7695307422327;2561.4236796720775;2093.0581238442687;2139.058814121789;2411.05968672218;2506.736792636774;2522.407234299938;2434.586120359543;2454.1038734587123;2455.1161581830524;2472.5673007223754;2472.9752702472924;2456.877156142186;2488.1789009626777;2488.365466805971;2489.614109812982;2493.613489909067;6936.4797640177185;7060.011598376232;7745.612719364066;7900.683972641087;7912.090109637408;5099.617528685363;5247.23915032322;5267.841964741064;5269.552088072518;5271.578273738091;3171.5559821624993;3190.266238765097;3233.7413006959387;3314.96685033149;3325.1687078230443;1019.7144799456164;1047.3703841850056;1058.745900983766;1063.494839951025;1091.0834898685143;12067.396630168456;12118.81821772674;12135.029197664166;12136.878631213664;12141.696457588543;4682.906341873211;4746.311784791255;4840.709557426566;4883.560479556786;4887.095887260868;9462.952685236667;9598.232141428809;9599.32804703664;9603.663871764455;9611.423314601147;5230.163173892159;5231.686098834082;5233.267342572043;5236.240745092016;5236.92144617831;4756.9286460703115;4807.663463557587;4818.8795280118275;4819.445763737145;4826.662133650681;3834.0606551395085;3837.846486140523;3880.0299925018744;3903.1998440319667;3914.745541539791;1112.3937454087543;1132.5809450503202;1155.8901904319075;1157.2651366382408;1163.598558497317;1384.4808196926153;1393.6794537256285;1402.8667276608705;1402.9298535073206;1429.492530151802;8197.180281971756;8341.20758527939;8341.624626891804;8364.916350836535;8375.95812020936;1188.8038473651923;1189.2745425290566;1196.21050106929;1202.7774861650623;1221.1146918484028;5965.910511342333;5978.192943952511;6589.703463344161;6632.104665870046;6645.036469711961;9435.669751558662;10220.437875916896;10346.275760696679;10347.27569070158;10371.066604005675;10063.64777232808;10186.286959912735;10385.065344119066;10524.947375263075;10537.315074520286;8122.187781221831;8139.267465927976;8236.711715089943;8244.54654993981;8247.670093196204;8014.358851292;8143.389245806469;8188.467749596257;8364.958175209329;8377.70678026266;9352.719418417459;9464.526773661151;9548.52257387114;9569.138777510057;9739.026097390488;9629.614815407305;9771.951140244253;9968.053034961667;9995;9996.750081248027;7272.8909066362985;7594.164641889277;7629.313361797243;7635.618219088912;7635.694572217049;8404.117567655308;8479.40644154928;8485.151484851465;8487.745367638981;8489.95755021221;7860.606969651609;8073.919260807317;8128.105908350195;8212.260896519341;8220.260176584135;7777.805554861174;7798.493097948615;7920.683172673029;7968.84062318762;8084.272415482635;7946.523208607502;8007.0391553014015;8022.719204827803;8199.918000819915;8216.835663286582;7398.371138453076;7442.479026468095;7458.5151965122095;7459.36595389398;7468.290512401313;7441.218672039358;7500.812479687833;7534.434917381109;7701.537907725555;7705.537667739954 11:27:25 INFO - PROCESS | 3813 | |4;prototype.html;356.88936429706786;358.8241761536848;368.90224090615976;370.2779579819353;370.8238586671333;6032.457078862902;6038.064100064492;6086.573939824214;6145.385461453852;6152.446279834825;5728.598998070137;5829.621074630146;5905.763769449217;5947.672877991719;6028.909566356509;4669.439667239936;4678.97660511697;4680.485146633868;4713.410823647044;4722.929156062662;4528.50186479487;4699.54314162609;4717.363155973934;4728.716277023373;4741.668083234175;4558.27067669173;4570.542945705436;4663;4676.228422310314;4677.64917631179;4634.467036290819;4648.74431906245;4651.976740116278;4667.533246675339;4674.368960190399;4107;4110.77390743509;4111.60939710727;4141.130362623852;4148.502179738451;5618.325800903876;5733.140028995643;5734.455226753452;5748.42515748426;5748.511376533;5400.648957817729;5431.293931788842;5443.918341224885;5445.482679145475;5447.603054655939;6411.3909178627955;6431.8392040198905;6475.320091390383;6489.870202595969;6491.415772580491;4483;4484.68607197493;4486.573775491323;4496.078303947683;4526.841560545398;6592.9011064833585;6660.067590537328;6715.496337774686;6724.83187920301;6733.797986060426;4606.654500912445;4612.100640375162;4614.377059097046;4617.076584683077;4618.745968971739;4675.1351000064415;4677.7193368398;4678.2280923647895;4687.9373075846515;4687.9765601171775;5403.783848646089;5406.162044883049;5411.810586629449;5417.26866872975;5420.376656684532;6351.079093531412;6479.7408103675325;6495.902561461582;6500;6501.284858665543;1636.3699975509276;1657.5110342449007;1662.7672125902384;1663.20166320167;1665.017639592622;1098.566066403766;1102.250469680625;1110.8278216876397;1120.7982563138714;1132.7564573616712;6264.467520260829;6272.5922815016875;6281.340459251713;6286.9056964145575;6288.937110628926;6447.548671592944;6650.933490665128;6670.299618540081;6677.23211830636;6721.731130754715;6177.783777567854;6224.688765561704;6335.556511044183;6343.777967771106;6343.777967771106;3547.077759782475;3612.8916132516065;3614.8915532534065;3615.3492371373404;3619.6199399063244;6714.83212919681;6895.379415852597;6908.620025898524;6921.169459664872;6924.065251191025;6929.133858267716;6936.826579335557;6944.965275173693;6947.756828510978;6951.617661028692;6951.165860096719;6953.79138625842;6959;6960;6965.79102626922;6619.933800662125;6629.933700662931;6631.6684165792485;6657.900131498128;6680.064790929371;6598.37315455031;6604;6625.569337993015;6626.138601981712;6629.502787290876;6801.489888258499;6833.658317084027;6853.211880633591;6870.45036397077;6872.244053154249;4616.007558374966;4690.343351930801;4691.50739172382;4692.53074692528;4698.2952557116705;6659.467242620675;6707.631080290435;6714.496412768965;6717.832054198684;6734.73061077571;6545.6399898004165;6571.145751052332;6577.079208910661;6578.276389597045;6635.303293154149;6509.498966433742;6529.412352888263;6535.607863528204;6601.075849381186;6612.173478315211;6357.745690172342;6362.840928976812;6366.77716279928;6370.140031095928;6370.235571731422;6565.277819439953;6598.901016484852;6629.270780214076;6641.369069938348;6647.268800432045;6257.124002639725;6374.6413826884345;6386.201724784402;6391.073294372383;6393 11:27:25 INFO - PROCESS | 3813 | |5;yui.html;826.3100311240114;832.4256263178406;834.1991687979539;903.3360480047169;943.8395472769629;14635.268236588168;14713.337899794507;14721.116732996028;14737.70524589509;14778.778318325234;13512.729745405111;15287.69424611507;15509.612259693513;15529.22353882307;15565.29956151973;705.587231469591;876.0538618292261;888.8400087984161;889.1020069729555;889.3107841422884;718.6011763471271;724.2865777209445;726.7783326085541;876.4741155306797;882.3029806452895;906.5557876640464;919.7746552094712;924.5469719837265;927.8654595083709;929.6142101028065;740.3928778401713;906.5467266366817;909.3043821476575;909.6952520905471;910.426431348253;556.1546449396894;673.2863165045019;677.3700458573525;680.8331958670108;683.2108914204102;14591.562253132422;14666.340014699364;14693.632659183499;14695.485658001919;14696.853031469655;13283.535076272381;13805.309734513234;13846.792298115537;13892.583222503341;13918.30408479572;11457.614667970422;11622.128340374506;11769.411529423494;11835.289882606985;11906.642800715992;3904.2777086239134;3916.15802602439;3969.2260009298197;3971.702122340836;3972.205558888234;47845;48384.75807620974;53416.73291633556;54897.725511372584;55000.449995500334;11174.832377514344;11200;11271.774564508827;11282.323060616389;11421.42892855354;18880;18885.43343699691;19045.7143142853;19065;19093.713594296096;8307.460015098999;8319.417640765208;8377.246047855722;8522.914770852212;8771.079036701181;4290.206311832321;4551.977240113778;4597.402337696145;4601.550511588839;4640.767961601907;3314.171457135716;3335.566376371105;3336.4995250712586;3338.88313909012;3346.4311067118647;589.0604485845071;594.2275042444891;595.0241603769821;598.7365559153958;639.0382474376034;682.5017737051979;706.9222385537689;713.4862898712919;732.1763016606318;741.280957471252;9102.635894564144;9110.225630821455;9122.86315705265;9131.041240669767;9348.345615806964;609.454538188319;693.7953303775398;752.7403045949138;757.2654525110634;761.4365369626437;4384.583464570861;4388.978055109704;4439.311906654474;4442.666799990014;4555.134524440346;63673;64427;64525.677371612845;64586.35413645898;64628.35371646317;56834.7158264206;56877.431225688044;56892.43107568871;56945.145822812694;57013;49165.508344916096;49174.99999999929;50091.24863127056;50774.23838642424;50823.49176508262;8833.911660883308;8977.192052715025;9036;9060.414427475298;9193.770155745893;35546.644533555365;35813;36380.81809590935;37051.25897482089;37642.05894852651;43754.781226094936;48097.519024809306;48413.757931210115;51027;51176.74411627918;11870.406479676154;12169.452374642986;12234.204776689487;12413.813792793297;12474.563390281659;12625.368731563569;12849.678758031125;13149.53976610814;13243.735125297248;13297.534586289821;12470.875291246972;12515.687107822014;12520.87479125197;12832.422540985865;12903.935480322538;12476.688082798002;12630.684232894251;12658.810117848423;12680.365981700694;12860.935695321463;11432.657020289405;12452.56416025471;12612.432440540015;13249.337533123113;13541.932290338485;9974.800503989734;10089.596416143271;10228.53971571296;10302.433366164933;10361.222908281758;9886.703398898044;10076.748081298027;10252.43611601369;10337.9483102584;10348.22388320894 11:27:25 INFO - PROCESS | 3813 | __end_tp_report 11:27:25 INFO - PROCESS | 3813 | __start_cc_report 11:27:25 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,655 11:27:25 INFO - PROCESS | 3813 | __end_cc_report 11:27:25 INFO - PROCESS | 3813 | __startTimestamp1457724445710__endTimestamp 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | ------- Summary: start ------- 11:27:25 INFO - PROCESS | 3813 | Number of tests: 6 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#0] dojo.html Cycles:165 Average:5346.68 Median:5519.23 stddev:566.61 (10.3%) stddev-sans-first:543.42 11:27:25 INFO - PROCESS | 3813 | Values: 3228.1 3302.5 3315.5 3326.1 3358.0 5327.3 5334.3 5335.2 5353.9 5359.8 5333.2 5348.2 5359.8 5360.0 5372.6 4809.3 4893.3 4896.0 4904.5 4944.7 4861.0 4869.1 4934.2 4940.1 4941.9 4844.8 4922.1 4926.0 5012.2 5013.6 4913.5 4917.6 4939.8 4941.3 4973.3 4771.3 4857.5 4866.4 4882.2 4922.6 5127.5 5206.5 5217.2 5224.2 5224.8 5658.6 5700.1 5705.6 5705.8 5710.8 5682.3 5691.5 5706.4 5738.3 5787.9 5451.1 5479.7 5482.6 5483.4 5485.0 5916.6 5917.9 5918.5 5924.1 5925.3 5547.3 5651.9 5662.5 5730.4 5741.8 5740.9 5747.8 5755.3 5760.4 5786.8 5720.0 5721.6 5723.2 5731.9 5734.2 5544.8 5645.5 5694.9 5711.5 5791.8 4434.9 4445.0 4453.6 4459.6 4480.8 4023.7 4024.8 4028.3 4061.2 4065.1 5327.8 5368.2 5374.1 5453.5 5459.6 5723.4 5725.1 5733.4 5733.5 5742.6 5420.5 5420.8 5423.8 5430.5 5436.8 4928.0 4985.7 4990.2 5010.6 5084.9 5879.1 5896.4 5914.5 5917.1 5918.3 5742.8 5766.4 5770.6 5773.3 5775.5 5697.9 5779.8 5804.0 5864.0 5894.6 5749.7 5759.5 5768.0 5781.6 5790.7 5633.7 5789.7 5846.9 5869.3 5874.1 5566.9 5624.6 5637.3 5638.1 5662.3 5601.7 5668.5 5671.4 5673.9 5680.9 5425.0 5515.6 5519.2 5535.0 5535.8 5622.3 5644.7 5669.0 5673.2 5721.9 5459.4 5480.3 5512.2 5513.2 5513.9 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#1] ext.html Cycles:180 Average:48656.66 Median:20584.66 stddev:81609.27 (396.5%) stddev-sans-first:81758.19 11:27:25 INFO - PROCESS | 3813 | Values: 527.4 529.4 551.2 577.4 591.0 29855.7 35634.0 35671.8 35713.8 35775.5 41410.4 42080.2 42141.6 42172.6 42211.6 8771.9 8975.5 8983.8 8983.9 8985.7 8658.4 8726.2 8749.0 8756.6 8788.9 8776.3 9065.5 9083.8 9090.0 9120.0 8865.4 9028.1 9032.2 9032.9 9037.5 8888.8 9005.7 9031.4 9035.2 9036.0 42362.4 42665.8 42889.8 42899.6 42941.8 3710.5 3770.6 3872.9 4216.6 4225.2 30799.8 32990.2 33142.7 33252.5 33264.7 3940.6 4042.8 4076.5 4098.6 4098.7 295276.0 297240.0 297855.0 298052.0 298093.0 57803.4 58927.0 66488.0 66490.3 66747.3 60171.4 60228.4 60394.0 60549.4 60634.7 15587.5 15589.4 15687.8 15695.7 15720.1 13363.2 13468.2 13477.9 13612.3 13616.2 21826.7 22363.3 22392.1 22456.8 22584.7 7279.1 7424.8 7571.0 7604.2 7626.8 1010.4 1010.7 1030.5 1103.3 1107.3 26240.7 26560.2 26721.9 27578.9 32763.0 1111.6 1133.4 1145.2 1237.9 1260.3 13793.2 15536.5 16202.9 16355.5 16367.5 312520.0 321332.0 322589.0 322792.0 323573.0 53954.5 54422.0 54451.7 54556.5 54576.0 1298.3 1487.5 1507.4 1514.6 1522.0 24634.4 28827.3 30205.0 30344.0 30914.8 54105.7 54897.7 54934.7 55041.7 55105.0 316224.0 317327.0 317986.0 319251.0 319311.0 30336.1 30765.0 34301.3 34479.8 35792.5 39532.0 39610.8 39628.6 40678.2 40783.4 37458.8 37459.6 37656.6 37663.2 38634.4 37568.1 38066.8 38246.2 38496.4 40851.0 34975.3 35711.0 35769.0 35954.8 35967.5 31083.0 32358.2 33160.0 33216.0 33368.8 23650.0 24008.9 24272.5 25028.1 25078.6 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#2] jquery.html Cycles:180 Average:27675.75 Median:370.76 stddev:87650.97 (23641.1%) stddev-sans-first:87872.86 11:27:25 INFO - PROCESS | 3813 | Values: 365.0 368.1 370.4 371.1 379.2 14100.2 15787.7 16407.8 17504.1 18181.9 10728.4 11226.6 11380.5 11473.9 11482.4 3807.8 4879.7 5018.1 5019.7 5020.0 3913.3 5237.4 5421.2 5422.3 5427.8 5376.9 5381.3 5564.4 5938.4 5973.1 5536.9 5957.8 5977.2 6004.4 6008.6 5383.5 5395.9 5396.1 5397.5 5401.6 12729.9 17473.5 20021.3 20591.5 20736.3 2155.8 2223.6 2249.3 2263.0 2270.5 9622.2 9671.7 11435.3 13174.9 13404.4 1738.3 1803.8 1985.8 2009.6 2039.4 54759.7 54955.0 55686.4 56645.2 56896.0 10096.9 10105.9 10126.6 10185.9 10186.8 12709.9 12743.6 12836.0 12871.1 12881.0 8062.6 8085.6 8101.8 8131.3 8143.5 8032.9 8074.9 8117.1 8117.1 8139.3 4316.8 4328.9 4418.8 4440.3 4478.6 1739.8 1764.4 1783.8 1808.7 1813.0 936.9 957.5 970.7 1049.7 1119.8 16294.0 16635.9 17151.2 17552.1 18329.8 979.9 1029.3 1040.8 1075.1 1096.3 9575.7 9958.6 10065.5 10070.9 10080.0 518814.0 519849.0 523101.0 556211.0 560558.0 67901.0 79455.0 79965.0 80705.0 82341.6 1223.0 1226.4 1230.3 1246.9 1273.3 15076.8 15082.2 15125.6 15131.2 15480.7 34017.0 34803.8 35387.6 35620.5 36475.3 44812.3 45045.3 45639.3 46153.5 47015.5 7548.8 7647.8 7696.8 7725.5 7793.8 8139.7 9609.5 10756.8 10859.9 11381.7 9719.2 9889.6 10097.8 10146.3 10218.8 9582.0 9754.5 9825.4 10047.5 10296.6 7268.7 9962.3 10155.7 10572.8 10772.4 7945.2 7988.4 8029.4 8044.5 8079.2 10303.4 10482.1 10688.0 10740.8 10753.4 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#3] mootools.html Cycles:180 Average:6061.57 Median:5257.54 stddev:3165.48 (60.2%) stddev-sans-first:3155.80 11:27:25 INFO - PROCESS | 3813 | Values: 1502.3 1504.7 1690.5 1815.0 1845.1 8277.3 8536.8 8540.1 8550.4 8561.7 8266.0 8382.4 8398.7 8433.5 8448.8 2449.4 2506.3 2522.8 2528.2 2530.7 2518.1 2543.8 2559.0 2560.8 2561.4 2093.1 2139.1 2411.1 2506.7 2522.4 2434.6 2454.1 2455.1 2472.6 2473.0 2456.9 2488.2 2488.4 2489.6 2493.6 6936.5 7060.0 7745.6 7900.7 7912.1 5099.6 5247.2 5267.8 5269.6 5271.6 3171.6 3190.3 3233.7 3315.0 3325.2 1019.7 1047.4 1058.7 1063.5 1091.1 12067.4 12118.8 12135.0 12136.9 12141.7 4682.9 4746.3 4840.7 4883.6 4887.1 9463.0 9598.2 9599.3 9603.7 9611.4 5230.2 5231.7 5233.3 5236.2 5236.9 4756.9 4807.7 4818.9 4819.4 4826.7 3834.1 3837.8 3880.0 3903.2 3914.7 1112.4 1132.6 1155.9 1157.3 1163.6 1384.5 1393.7 1402.9 1402.9 1429.5 8197.2 8341.2 8341.6 8364.9 8376.0 1188.8 1189.3 1196.2 1202.8 1221.1 5965.9 5978.2 6589.7 6632.1 6645.0 9435.7 10220.4 10346.3 10347.3 10371.1 10063.6 10186.3 10385.1 10524.9 10537.3 8122.2 8139.3 8236.7 8244.5 8247.7 8014.4 8143.4 8188.5 8365.0 8377.7 9352.7 9464.5 9548.5 9569.1 9739.0 9629.6 9772.0 9968.1 9995.0 9996.8 7272.9 7594.2 7629.3 7635.6 7635.7 8404.1 8479.4 8485.2 8487.7 8490.0 7860.6 8073.9 8128.1 8212.3 8220.3 7777.8 7798.5 7920.7 7968.8 8084.3 7946.5 8007.0 8022.7 8199.9 8216.8 7398.4 7442.5 7458.5 7459.4 7468.3 7441.2 7500.8 7534.4 7701.5 7705.5 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#4] prototype.html Cycles:180 Average:5427.99 Median:6201.24 stddev:1628.57 (26.3%) stddev-sans-first:1588.03 11:27:25 INFO - PROCESS | 3813 | Values: 356.9 358.8 368.9 370.3 370.8 6032.5 6038.1 6086.6 6145.4 6152.4 5728.6 5829.6 5905.8 5947.7 6028.9 4669.4 4679.0 4680.5 4713.4 4722.9 4528.5 4699.5 4717.4 4728.7 4741.7 4558.3 4570.5 4663.0 4676.2 4677.6 4634.5 4648.7 4652.0 4667.5 4674.4 4107.0 4110.8 4111.6 4141.1 4148.5 5618.3 5733.1 5734.5 5748.4 5748.5 5400.6 5431.3 5443.9 5445.5 5447.6 6411.4 6431.8 6475.3 6489.9 6491.4 4483.0 4484.7 4486.6 4496.1 4526.8 6592.9 6660.1 6715.5 6724.8 6733.8 4606.7 4612.1 4614.4 4617.1 4618.7 4675.1 4677.7 4678.2 4687.9 4688.0 5403.8 5406.2 5411.8 5417.3 5420.4 6351.1 6479.7 6495.9 6500.0 6501.3 1636.4 1657.5 1662.8 1663.2 1665.0 1098.6 1102.3 1110.8 1120.8 1132.8 6264.5 6272.6 6281.3 6286.9 6288.9 6447.5 6650.9 6670.3 6677.2 6721.7 6177.8 6224.7 6335.6 6343.8 6343.8 3547.1 3612.9 3614.9 3615.3 3619.6 6714.8 6895.4 6908.6 6921.2 6924.1 6929.1 6936.8 6945.0 6947.8 6951.6 6951.2 6953.8 6959.0 6960.0 6965.8 6619.9 6629.9 6631.7 6657.9 6680.1 6598.4 6604.0 6625.6 6626.1 6629.5 6801.5 6833.7 6853.2 6870.5 6872.2 4616.0 4690.3 4691.5 4692.5 4698.3 6659.5 6707.6 6714.5 6717.8 6734.7 6545.6 6571.1 6577.1 6578.3 6635.3 6509.5 6529.4 6535.6 6601.1 6612.2 6357.7 6362.8 6366.8 6370.1 6370.2 6565.3 6598.9 6629.3 6641.4 6647.3 6257.1 6374.6 6386.2 6391.1 6393.0 11:27:25 INFO - PROCESS | 3813 | 11:27:25 INFO - PROCESS | 3813 | [#5] yui.html Cycles:180 Average:15051.96 Median:4576.27 stddev:17460.62 (381.5%) stddev-sans-first:17476.92 11:27:25 INFO - PROCESS | 3813 | Values: 826.3 832.4 834.2 903.3 943.8 14635.3 14713.3 14721.1 14737.7 14778.8 13512.7 15287.7 15509.6 15529.2 15565.3 705.6 876.1 888.8 889.1 889.3 718.6 724.3 726.8 876.5 882.3 906.6 919.8 924.5 927.9 929.6 740.4 906.5 909.3 909.7 910.4 556.2 673.3 677.4 680.8 683.2 14591.6 14666.3 14693.6 14695.5 14696.9 13283.5 13805.3 13846.8 13892.6 13918.3 11457.6 11622.1 11769.4 11835.3 11906.6 3904.3 3916.2 3969.2 3971.7 3972.2 47845.0 48384.8 53416.7 54897.7 55000.4 11174.8 11200.0 11271.8 11282.3 11421.4 18880.0 18885.4 19045.7 19065.0 19093.7 8307.5 8319.4 8377.2 8522.9 8771.1 4290.2 4552.0 4597.4 4601.6 4640.8 3314.2 3335.6 3336.5 3338.9 3346.4 589.1 594.2 595.0 598.7 639.0 682.5 706.9 713.5 732.2 741.3 9102.6 9110.2 9122.9 9131.0 9348.3 609.5 693.8 752.7 757.3 761.4 4384.6 4389.0 4439.3 4442.7 4555.1 63673.0 64427.0 64525.7 64586.4 64628.4 56834.7 56877.4 56892.4 56945.1 57013.0 49165.5 49175.0 50091.2 50774.2 50823.5 8833.9 8977.2 9036.0 9060.4 9193.8 35546.6 35813.0 36380.8 37051.3 37642.1 43754.8 48097.5 48413.8 51027.0 51176.7 11870.4 12169.5 12234.2 12413.8 12474.6 12625.4 12849.7 13149.5 13243.7 13297.5 12470.9 12515.7 12520.9 12832.4 12903.9 12476.7 12630.7 12658.8 12680.4 12860.9 11432.7 12452.6 12612.4 13249.3 13541.9 9974.8 10089.6 10228.5 10302.4 10361.2 9886.7 10076.7 10252.4 10337.9 10348.2 11:27:25 INFO - PROCESS | 3813 | -------- Summary: end -------- 11:27:25 INFO - PROCESS | 3813 | 11:27:26 INFO - TEST-INFO | 3813: exit 0 11:27:26 INFO - TEST-OK | dromaeo_css | took 1109765ms 11:27:26 INFO - TEST-START | kraken 11:27:26 INFO - operating with platform_type : linux_ 11:27:26 INFO - Initialising browser for kraken test... 11:27:26 INFO - TEST-INFO | started process 4010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDjKnK/profile http://localhost:48122/getInfo.html) 11:27:30 INFO - PROCESS | 4010 | __metrics Screen width/height:1600/1200 11:27:30 INFO - PROCESS | 4010 | colorDepth:24 11:27:30 INFO - PROCESS | 4010 | Browser inner width/height: 1024/697 11:27:30 INFO - PROCESS | 4010 | __metrics 11:27:30 INFO - PROCESS | 4010 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:31 INFO - TEST-INFO | 4010: exit 0 11:27:31 INFO - Browser initialized. 11:27:31 INFO - Running cycle 1/1 for kraken test... 11:27:31 INFO - TEST-INFO | started process 4100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDjKnK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:42 INFO - PROCESS | 4100 | RSS: Main: 135835648 11:27:42 INFO - PROCESS | 4100 | 11:27:45 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48122/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:45 INFO - PROCESS | 4100 | RSS: Main: 170086400 11:27:45 INFO - PROCESS | 4100 | 11:27:48 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48122/tests/kraken/driver.html?testName=audio-dft) 11:27:49 INFO - PROCESS | 4100 | RSS: Main: 168259584 11:27:49 INFO - PROCESS | 4100 | 11:27:51 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48122/tests/kraken/driver.html?testName=audio-fft) 11:27:52 INFO - PROCESS | 4100 | RSS: Main: 164614144 11:27:52 INFO - PROCESS | 4100 | 11:27:54 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48122/tests/kraken/driver.html?testName=audio-oscillator) 11:27:55 INFO - PROCESS | 4100 | RSS: Main: 165834752 11:27:55 INFO - PROCESS | 4100 | 11:27:57 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:57 INFO - PROCESS | 4100 | RSS: Main: 165019648 11:27:57 INFO - PROCESS | 4100 | 11:28:00 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48122/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:01 INFO - PROCESS | 4100 | RSS: Main: 165302272 11:28:01 INFO - PROCESS | 4100 | 11:28:04 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48122/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:05 INFO - PROCESS | 4100 | RSS: Main: 165998592 11:28:05 INFO - PROCESS | 4100 | 11:28:07 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48122/tests/kraken/driver.html?testName=json-parse-financial) 11:28:08 INFO - PROCESS | 4100 | RSS: Main: 164057088 11:28:08 INFO - PROCESS | 4100 | 11:28:09 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:10 INFO - PROCESS | 4100 | RSS: Main: 168136704 11:28:10 INFO - PROCESS | 4100 | 11:28:12 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:12 INFO - PROCESS | 4100 | RSS: Main: 166678528 11:28:12 INFO - PROCESS | 4100 | 11:28:14 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:15 INFO - PROCESS | 4100 | RSS: Main: 171913216 11:28:15 INFO - PROCESS | 4100 | 11:28:17 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:18 INFO - PROCESS | 4100 | RSS: Main: 177143808 11:28:18 INFO - PROCESS | 4100 | 11:28:20 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:21 INFO - PROCESS | 4100 | RSS: Main: 174530560 11:28:21 INFO - PROCESS | 4100 | 11:28:22 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:48122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48122/tests/kraken/driver.html?testName=ai-astar) 11:28:23 INFO - PROCESS | 4100 | RSS: Main: 234807296 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | __start_tp_report 11:28:23 INFO - PROCESS | 4100 | _x_x_mozilla_page_load 11:28:23 INFO - PROCESS | 4100 | _x_x_mozilla_page_load_details 11:28:23 INFO - PROCESS | 4100 | |i|pagename|runs| 11:28:23 INFO - PROCESS | 4100 | |0;ai-astar;111;112;106;110;111;110;101;110;110;110 11:28:23 INFO - PROCESS | 4100 | |1;audio-beat-detection;145;128;158;167;131;149;153;132;162;121 11:28:23 INFO - PROCESS | 4100 | |2;audio-dft;159;160;161;161;161;159;159;162;161;161 11:28:23 INFO - PROCESS | 4100 | |3;audio-fft;76;75;74;142;75;73;79;73;154;74 11:28:23 INFO - PROCESS | 4100 | |4;audio-oscillator;95;95;149;95;95;95;134;93;94;140 11:28:23 INFO - PROCESS | 4100 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;110;109;109 11:28:23 INFO - PROCESS | 4100 | |6;imaging-darkroom;145;146;147;145;145;145;146;146;145;146 11:28:23 INFO - PROCESS | 4100 | |7;imaging-desaturate;96;96;95;95;96;95;95;96;96;96 11:28:23 INFO - PROCESS | 4100 | |8;json-parse-financial;53;53;54;53;53;54;56;53;53;52 11:28:23 INFO - PROCESS | 4100 | |9;json-stringify-tinderbox;63;63;64;63;65;64;64;64;78;65 11:28:23 INFO - PROCESS | 4100 | |10;stanford-crypto-aes;77;77;86;79;88;85;80;78;79;79 11:28:23 INFO - PROCESS | 4100 | |11;stanford-crypto-ccm;117;109;110;117;117;113;115;111;112;113 11:28:23 INFO - PROCESS | 4100 | |12;stanford-crypto-pbkdf2;135;126;129;134;140;129;147;135;136;132 11:28:23 INFO - PROCESS | 4100 | |13;stanford-crypto-sha256-iterative;65;64;65;63;65;64;66;65;64;62 11:28:23 INFO - PROCESS | 4100 | __end_tp_report 11:28:23 INFO - PROCESS | 4100 | __start_cc_report 11:28:23 INFO - PROCESS | 4100 | _x_x_mozilla_cycle_collect,922 11:28:23 INFO - PROCESS | 4100 | __end_cc_report 11:28:23 INFO - PROCESS | 4100 | __startTimestamp1457724503245__endTimestamp 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | ------- Summary: start ------- 11:28:23 INFO - PROCESS | 4100 | Number of tests: 14 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.25 (3.0%) stddev-sans-first:3.37 11:28:23 INFO - PROCESS | 4100 | Values: 111.0 112.0 106.0 110.0 111.0 110.0 101.0 110.0 110.0 110.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.00 stddev:15.81 (10.5%) stddev-sans-first:16.77 11:28:23 INFO - PROCESS | 4100 | Values: 145.0 128.0 158.0 167.0 131.0 149.0 153.0 132.0 162.0 121.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.01 11:28:23 INFO - PROCESS | 4100 | Values: 159.0 160.0 161.0 161.0 161.0 159.0 159.0 162.0 161.0 161.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#3] audio-fft Cycles:10 Average:89.50 Median:74.50 stddev:31.01 (41.6%) stddev-sans-first:32.50 11:28:23 INFO - PROCESS | 4100 | Values: 76.0 75.0 74.0 142.0 75.0 73.0 79.0 73.0 154.0 74.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:22.72 (23.9%) stddev-sans-first:23.56 11:28:23 INFO - PROCESS | 4100 | Values: 95.0 95.0 149.0 95.0 95.0 95.0 134.0 93.0 94.0 140.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:28:23 INFO - PROCESS | 4100 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 110.0 109.0 109.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:28:23 INFO - PROCESS | 4100 | Values: 145.0 146.0 147.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:28:23 INFO - PROCESS | 4100 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.13 11:28:23 INFO - PROCESS | 4100 | Values: 53.0 53.0 54.0 53.0 53.0 54.0 56.0 53.0 53.0 52.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:64.00 stddev:4.52 (7.1%) stddev-sans-first:4.72 11:28:23 INFO - PROCESS | 4100 | Values: 63.0 63.0 64.0 63.0 65.0 64.0 64.0 64.0 78.0 65.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.50 stddev:3.99 (5.0%) stddev-sans-first:3.99 11:28:23 INFO - PROCESS | 4100 | Values: 77.0 77.0 86.0 79.0 88.0 85.0 80.0 78.0 79.0 79.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.00 stddev:2.99 (2.6%) stddev-sans-first:2.87 11:28:23 INFO - PROCESS | 4100 | Values: 117.0 109.0 110.0 117.0 117.0 113.0 115.0 111.0 112.0 113.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.30 Median:135.00 stddev:6.04 (4.5%) stddev-sans-first:6.40 11:28:23 INFO - PROCESS | 4100 | Values: 135.0 126.0 129.0 134.0 140.0 129.0 147.0 135.0 136.0 132.0 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - PROCESS | 4100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 11:28:23 INFO - PROCESS | 4100 | Values: 65.0 64.0 65.0 63.0 65.0 64.0 66.0 65.0 64.0 62.0 11:28:23 INFO - PROCESS | 4100 | -------- Summary: end -------- 11:28:23 INFO - PROCESS | 4100 | 11:28:23 INFO - TEST-INFO | 4100: exit 0 11:28:24 INFO - TEST-OK | kraken | took 57714ms 11:28:24 INFO - TEST-START | v8_7 11:28:24 INFO - operating with platform_type : linux_ 11:28:24 INFO - Initialising browser for v8_7 test... 11:28:24 INFO - TEST-INFO | started process 4354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeoZfM/profile http://localhost:48122/getInfo.html) 11:28:27 INFO - PROCESS | 4354 | __metrics Screen width/height:1600/1200 11:28:27 INFO - PROCESS | 4354 | colorDepth:24 11:28:27 INFO - PROCESS | 4354 | Browser inner width/height: 1024/697 11:28:27 INFO - PROCESS | 4354 | __metrics 11:28:28 INFO - PROCESS | 4354 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:28 INFO - TEST-INFO | 4354: exit 0 11:28:28 INFO - Browser initialized. 11:28:28 INFO - Running cycle 1/1 for v8_7 test... 11:28:28 INFO - TEST-INFO | started process 4443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAeoZfM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:40 INFO - PROCESS | 4443 | RSS: Main: 136130560 11:28:40 INFO - PROCESS | 4443 | 11:29:02 INFO - PROCESS | 4443 | Cycle 1(1): loaded http://localhost:48122/tests/v8_7/run.html (next: http://localhost:48122/tests/v8_7/run.html) 11:29:03 INFO - PROCESS | 4443 | RSS: Main: 421896192 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | __start_tp_report 11:29:03 INFO - PROCESS | 4443 | _x_x_mozilla_page_load 11:29:03 INFO - PROCESS | 4443 | _x_x_mozilla_page_load_details 11:29:03 INFO - PROCESS | 4443 | |i|pagename|runs| 11:29:03 INFO - PROCESS | 4443 | |0;Richards;167.42005692281936 11:29:03 INFO - PROCESS | 4443 | |1;DeltaBlue;170.38677798602828 11:29:03 INFO - PROCESS | 4443 | |2;Encrypt;278.9400278940028 11:29:03 INFO - PROCESS | 4443 | |3;Decrypt;5191.709844559586 11:29:03 INFO - PROCESS | 4443 | |4;RayTrace;958.7727708533077 11:29:03 INFO - PROCESS | 4443 | |5;Earley;557.4136008918617 11:29:03 INFO - PROCESS | 4443 | |6;Boyer;10765.95744680851 11:29:03 INFO - PROCESS | 4443 | |7;RegExp;39921.56862745098 11:29:03 INFO - PROCESS | 4443 | |8;Splay;520.8333333333334 11:29:03 INFO - PROCESS | 4443 | |9;NavierStokes;4840.579710144928 11:29:03 INFO - PROCESS | 4443 | __end_tp_report 11:29:03 INFO - PROCESS | 4443 | __startTimestamp1457724543210__endTimestamp 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | ------- Summary: start ------- 11:29:03 INFO - PROCESS | 4443 | Number of tests: 10 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 167.4 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#1] DeltaBlue Cycles:1 Average:170.39 Median:170.39 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 170.4 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 278.9 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 5191.7 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 958.8 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#5] Earley Cycles:1 Average:557.41 Median:557.41 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 557.4 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#6] Boyer Cycles:1 Average:10765.96 Median:10765.96 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 10766.0 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#7] RegExp Cycles:1 Average:39921.57 Median:39921.57 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 39921.6 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#8] Splay Cycles:1 Average:520.83 Median:520.83 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 520.8 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - PROCESS | 4443 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:29:03 INFO - PROCESS | 4443 | Values: 4840.6 11:29:03 INFO - PROCESS | 4443 | -------- Summary: end -------- 11:29:03 INFO - PROCESS | 4443 | 11:29:03 INFO - TEST-INFO | 4443: exit 0 11:29:03 INFO - TEST-OK | v8_7 | took 39915ms 11:29:03 INFO - SUITE-END | took 1207s 11:29:04 INFO - Completed test suite (00:20:07) 11:29:04 INFO - Working with test: dromaeo_css 11:29:04 INFO - Generating results file: dromaeo_css 11:29:04 INFO - Working with test: kraken 11:29:04 INFO - Generating results file: kraken 11:29:04 INFO - javascript benchmark 11:29:04 INFO - Working with test: v8_7 11:29:04 INFO - Generating results file: v8_7 11:29:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 11:29:04 INFO - process_Request line: dromaeo_css 7216.59 graph.html#tests=[[72,181,35]] 11:29:04 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:04 INFO - process_Request line: kraken 1473.80 graph.html#tests=[[232,181,35]] 11:29:04 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:04 INFO - process_Request line: v8_7 21986.15 graph.html#tests=[[230,181,35]] 11:29:04 INFO - RETURN: dromaeo_css: 7216.59 11:29:04 INFO - RETURN: kraken: 1473.80 11:29:04 INFO - RETURN: v8_7: 21986.15 11:29:04 INFO - javascript benchmark 11:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3228.1122691259907, 3302.504624306352, 3315.535824984504, 3326.101952472832, 3357.999999999999, 5327.254184414185, 5334.333208348957, 5335.173048177529, 5353.866153346168, 5359.758810853511, 5333.173358129496, 5348.197770334452, 5359.812406565771, 5360.035193665139, 5372.57019438445, 4809.302651115586, 4893.339399181101, 4895.951040489603, 4904.509549045102, 4944.678595891273, 4861.027794441108, 4869.050535145648, 4934.161192597249, 4940.086084074458, 4941.851744447672, 4844.806207751686, 4922.138625740499, 4925.950740492603, 5012.198048312271, 5013.5989120870245, 4913.533214344631, 4917.631177661672, 4939.777710003059, 4941.308216849626, 4973.3286006389035, 4771.308160316769, 4857.53853383928, 4866.416030076413, 4882.218844984785, 4922.630802689777, 5127.48725127488, 5206.505381988705, 5217.191335343028, 5224.190250511177, 5224.843254702365, 5658.575606829504, 5700.144978253254, 5705.62913410627, 5705.800296989627, 5710.771569137271, 5682.289713785777, 5691.459311365414, 5706.400827913051, 5738.311402631669, 5787.942120578782, 5451.073317536028, 5479.698616576086, 5482.616216864821, 5483.424240454775, 5485.040117979377, 5916.645001299936, 5917.911231331447, 5918.467337939606, 5924.081767326072, 5925.318588362307, 5547.278853749068, 5651.858703532444, 5662.518685911744, 5730.36965933747, 5741.770329186869, 5740.942590574041, 5747.827565173052, 5755.280589926259, 5760.42395760429, 5786.768529258867, 5720.027595308808, 5721.5708821838525, 5723.170140329629, 5731.914021289684, 5734.168545560954, 5544.750486228129, 5645.5201307888465, 5694.9430505695245, 5711.457411545896, 5791.768329266866, 4434.911301773946, 4445.044315472124, 4453.621442177451, 4459.598636122764, 4480.820767169342, 4023.6781057515327, 4024.7987600619854, 4028.295048366524, 4061.248668996186, 4065.1259979104634, 5327.786888524493, 5368.248445217672, 5374.140137577969, 5453.509184173444, 5459.645123066988, 5723.427657234243, 5725.08398656213, 5733.426657334233, 5733.483986441241, 5742.626729262584, 5420.539254163361, 5420.810271640474, 5423.755930983115, 5430.456954304538, 5436.809711660152, 4928.0, 4985.725785081855, 4990.17662085759, 5010.574101201366, 5084.906745049758, 5879.059350503984, 5896.410358964069, 5914.497267732291, 5917.142014407973, 5918.348981612019, 5742.827715168552, 5766.394528574607, 5770.596058275881, 5773.3072031356505, 5775.451332123442, 5697.857553561194, 5779.768809247751, 5804.042333015174, 5863.973804584266, 5894.587378883437, 5749.741261643152, 5759.481646651654, 5768.0, 5781.566382521243, 5790.710464476843, 5633.746481408429, 5789.739461724317, 5846.853828654318, 5869.325027621878, 5874.060150375919, 5566.91649625264, 5624.634398764068, 5637.267155269788, 5638.097904335286, 5662.320521537277, 5601.663900166003, 5668.518175954925, 5671.432856714296, 5673.943260567342, 5680.857978550569, 5425.0, 5515.58633102527, 5519.227308176939, 5534.972325138348, 5535.833924982257, 5622.32532096151, 5644.6613203207935, 5668.971655141698, 5673.205751194919, 5721.8569535761935, 5459.372172200247, 5480.314960629921, 5512.228288039758, 5513.2005859151, 5513.889722205614], "unit": "score", "name": "dojo.html", "value": 5311.813501519995}, {"lowerIsBetter": false, "replicates": [527.42247239273, 529.3568314497884, 551.1842473139753, 577.3995045153041, 590.9982579527702, 29855.701442985563, 35634.0, 35671.821640891794, 35713.82143089284, 35775.4633680495, 41410.37884431736, 42080.15839683205, 42141.57858421415, 42172.578274217245, 42211.57788422115, 8771.868421973692, 8975.461472311683, 8983.820323593523, 8983.865242021375, 8985.730428087169, 8658.350623703247, 8726.171013753683, 8748.956255218714, 8756.649734010633, 8788.912110878906, 8776.297896168291, 9065.501397423139, 9083.772905677344, 9090.045545217723, 9120.0, 8865.379423440361, 9028.052054534277, 9032.187103160748, 9032.8645070324, 9037.502937338444, 8888.822223555557, 9005.684801031932, 9031.412958157764, 9035.18683318498, 9036.0, 42362.364564531556, 42665.786671066446, 42889.78555107236, 42899.57100428987, 42941.785291073655, 3710.499082623838, 3770.604086570898, 3872.883813485572, 4216.64158546524, 4225.197212529641, 30799.846000770078, 32990.17524561881, 33142.6685733142, 33252.50121248183, 33264.6673533264, 3940.6059394060653, 4042.8239874223195, 4076.470058892325, 4098.561111582469, 4098.6516146127315, 295276.0, 297240.0, 297855.0, 298052.0, 298093.0, 57803.421965780646, 58927.0, 66488.0, 66490.33509664841, 66747.33252667412, 60171.39828601658, 60228.39771602228, 60394.0, 60549.39450605526, 60634.69682651559, 15587.454439094805, 15589.376424942875, 15687.843121568867, 15695.68608627821, 15720.135392553291, 13363.198208107544, 13468.191908485522, 13477.932610337082, 13612.31938403076, 13616.18302901829, 21826.672599911013, 22363.329100127023, 22392.10431582751, 22456.775432245468, 22584.66123008156, 7279.1265048194555, 7424.814379640552, 7571.0, 7604.163542010375, 7626.771196864103, 1010.3887148275335, 1010.6513252927729, 1030.4590090202553, 1103.315944114654, 1107.3189988157226, 26240.73759262383, 26560.203193904214, 26721.86639066831, 27578.862105689743, 32763.0, 1111.6164923101517, 1133.3766428464476, 1145.1869172887177, 1237.8762123787549, 1260.3383223807575, 13793.24137172445, 15536.533903982898, 16202.918985404998, 16355.509334719978, 16367.508974730777, 312520.0, 321332.0, 322589.0, 322792.0, 323573.0, 53954.46045539495, 54422.0, 54451.72774136183, 54556.45443545593, 54576.0, 1298.2664794391328, 1487.4868170481166, 1507.366905899525, 1514.6440586462172, 1522.0259034218109, 24634.384140396633, 28827.279318017216, 30205.0, 30344.0, 30914.845425772728, 54105.72947135397, 54897.725511372184, 54934.72532637311, 55041.72479137579, 55105.0, 316224.0, 317327.0, 317986.0, 319251.0, 319311.0, 30336.089917302517, 30765.0, 34301.31397371989, 34479.827600861834, 35792.46311305281, 39532.0, 39610.80194599008, 39628.60371396249, 40678.1864362717, 40783.388249175696, 37458.81270593739, 37459.62540374562, 37656.623433765315, 37663.246735065695, 38634.42048369221, 37568.060798480255, 38066.80966595149, 38246.23507529778, 38496.422553662276, 40851.0, 34975.300493990486, 35711.0, 35769.0, 35954.82022589975, 35967.460488093224, 31083.0, 32358.19104522406, 33160.0, 33216.0, 33368.833155834065, 23650.0, 24008.87995560011, 24272.514549708554, 25028.124015659363, 25078.62382064234], "unit": "score", "name": "ext.html", "value": 19208.979800464444}, {"lowerIsBetter": false, "replicates": [364.9580298265699, 368.101831531064, 370.39440514758377, 371.11859334081555, 379.23583978283745, 14100.153990760562, 15787.684246315066, 16407.835921640795, 17504.124793760308, 18181.909090454545, 10728.356298622088, 11226.550937962493, 11380.487878045487, 11473.942630286836, 11482.368469734161, 3807.7715337079726, 4879.658423910328, 5018.121828679967, 5019.673721208128, 5020.046191223656, 3913.2956067907767, 5237.397699264595, 5421.159720243349, 5422.322209723785, 5427.83716488504, 5376.865578360553, 5381.273528073719, 5564.415736347686, 5938.376470470603, 5973.074173503114, 5536.944630553683, 5957.761689532414, 5977.22296101504, 6004.42957918997, 6008.579399442019, 5383.488568585978, 5395.919061214085, 5396.10964190908, 5397.460253974571, 5401.567874570025, 12729.936350318281, 17473.47579572615, 20021.299254526166, 20591.485212869797, 20736.274230401865, 2155.75208850981, 2223.566404551113, 2249.347689170139, 2262.9773702262933, 2270.4891399434996, 9622.182114520205, 9671.661491847823, 11435.256708313933, 13174.914722642521, 13404.396802143927, 1738.3220543987854, 1803.8286362795513, 1985.7815640279557, 2009.6282187795305, 2039.3983774786473, 54759.726201369136, 54955.0, 55686.44313556853, 56645.15032274519, 56896.0, 10096.949515252523, 10105.898941010642, 10126.645567405252, 10185.9490702546, 10186.847197292047, 12709.93645031769, 12743.617691469271, 12836.0, 12871.099023068482, 12881.0, 8062.596870156469, 8085.555294458862, 8101.837963240702, 8131.349492040623, 8143.470674406145, 8032.879506807402, 8074.919250807417, 8117.107118216992, 8117.107118216992, 8139.348852091818, 4316.762578058174, 4328.9134217316105, 4418.8453404130705, 4440.267355886307, 4478.641708663299, 1739.7738294021697, 1764.4001039646582, 1783.8216178382318, 1808.6563552924902, 1812.9546761330807, 936.9156775890202, 957.5499515227832, 970.669972209438, 1049.6588608702202, 1119.8096323625002, 16294.0, 16635.91682041582, 17151.228194731266, 17552.122393880254, 18329.81670183308, 979.8628192052976, 1029.325791606499, 1040.843873418993, 1075.1291453922347, 1096.331237944853, 9575.712728618153, 9958.601655933682, 10065.496725163712, 10070.899291006996, 10080.0, 518814.0, 519849.0, 523101.0, 556211.0, 560558.0, 67901.0, 79455.0, 79965.0, 80705.0, 82341.58829205815, 1223.0215827337915, 1226.4419689041465, 1230.3233221728015, 1246.9300960405865, 1273.2869593027933, 15076.773848392064, 15082.24588770579, 15125.621859453602, 15131.167785771888, 15480.690386192438, 34017.0, 34803.82598086994, 35387.646123538434, 35620.46569301515, 36475.27049458943, 44812.32781508215, 45045.32432013588, 45639.31541026953, 46153.538464614925, 47015.52984470248, 7548.849023019399, 7647.847043058996, 7696.846063078595, 7725.459217854696, 7793.766187014398, 8139.674413023413, 9609.51952402391, 10756.838647420138, 10859.945700271448, 11381.715457113638, 9719.222462202866, 9889.554970026222, 10097.798044039226, 10146.340487868265, 10218.795624087625, 9582.0, 9754.463504507037, 9825.4104753715, 10047.497625118862, 10296.588136474757, 7268.745593904188, 9962.302638815503, 10155.695329140137, 10572.788544228919, 10772.407517586607, 7945.165757595601, 7988.360931125612, 8029.397795165269, 8044.517328960281, 8079.151689072798, 10303.3817970922, 10482.109020733018, 10688.038076573146, 10740.785184296426, 10753.408562528823], "unit": "score", "name": "jquery.html", "value": 8341.04577884474}, {"lowerIsBetter": false, "replicates": [1502.3314624991879, 1504.7141043201793, 1690.4759524547392, 1815.0289595066643, 1845.0774612693654, 8277.337812974962, 8536.829263414736, 8540.060593334729, 8550.444221125637, 8561.65753369866, 8266.049404318504, 8382.413231073828, 8398.748037558884, 8433.524133276667, 8448.78878028048, 2449.448874003344, 2506.29823649378, 2522.823402361835, 2528.190978886757, 2530.6710127683377, 2518.055729101587, 2543.78377837884, 2558.9744102559016, 2560.7695307422327, 2561.4236796720775, 2093.0581238442687, 2139.058814121789, 2411.05968672218, 2506.736792636774, 2522.407234299938, 2434.586120359543, 2454.1038734587123, 2455.1161581830524, 2472.5673007223754, 2472.9752702472924, 2456.877156142186, 2488.1789009626777, 2488.365466805971, 2489.614109812982, 2493.613489909067, 6936.4797640177185, 7060.011598376232, 7745.612719364066, 7900.683972641087, 7912.090109637408, 5099.617528685363, 5247.23915032322, 5267.841964741064, 5269.552088072518, 5271.578273738091, 3171.5559821624993, 3190.266238765097, 3233.7413006959387, 3314.96685033149, 3325.1687078230443, 1019.7144799456164, 1047.3703841850056, 1058.745900983766, 1063.494839951025, 1091.0834898685143, 12067.396630168456, 12118.81821772674, 12135.029197664166, 12136.878631213664, 12141.696457588543, 4682.906341873211, 4746.311784791255, 4840.709557426566, 4883.560479556786, 4887.095887260868, 9462.952685236667, 9598.232141428809, 9599.32804703664, 9603.663871764455, 9611.423314601147, 5230.163173892159, 5231.686098834082, 5233.267342572043, 5236.240745092016, 5236.92144617831, 4756.9286460703115, 4807.663463557587, 4818.8795280118275, 4819.445763737145, 4826.662133650681, 3834.0606551395085, 3837.846486140523, 3880.0299925018744, 3903.1998440319667, 3914.745541539791, 1112.3937454087543, 1132.5809450503202, 1155.8901904319075, 1157.2651366382408, 1163.598558497317, 1384.4808196926153, 1393.6794537256285, 1402.8667276608705, 1402.9298535073206, 1429.492530151802, 8197.180281971756, 8341.20758527939, 8341.624626891804, 8364.916350836535, 8375.95812020936, 1188.8038473651923, 1189.2745425290566, 1196.21050106929, 1202.7774861650623, 1221.1146918484028, 5965.910511342333, 5978.192943952511, 6589.703463344161, 6632.104665870046, 6645.036469711961, 9435.669751558662, 10220.437875916896, 10346.275760696679, 10347.27569070158, 10371.066604005675, 10063.64777232808, 10186.286959912735, 10385.065344119066, 10524.947375263075, 10537.315074520286, 8122.187781221831, 8139.267465927976, 8236.711715089943, 8244.54654993981, 8247.670093196204, 8014.358851292, 8143.389245806469, 8188.467749596257, 8364.958175209329, 8377.70678026266, 9352.719418417459, 9464.526773661151, 9548.52257387114, 9569.138777510057, 9739.026097390488, 9629.614815407305, 9771.951140244253, 9968.053034961667, 9995.0, 9996.750081248027, 7272.8909066362985, 7594.164641889277, 7629.313361797243, 7635.618219088912, 7635.694572217049, 8404.117567655308, 8479.40644154928, 8485.151484851465, 8487.745367638981, 8489.95755021221, 7860.606969651609, 8073.919260807317, 8128.105908350195, 8212.260896519341, 8220.260176584135, 7777.805554861174, 7798.493097948615, 7920.683172673029, 7968.84062318762, 8084.272415482635, 7946.523208607502, 8007.0391553014015, 8022.719204827803, 8199.918000819915, 8216.835663286582, 7398.371138453076, 7442.479026468095, 7458.5151965122095, 7459.36595389398, 7468.290512401313, 7441.218672039358, 7500.812479687833, 7534.434917381109, 7701.537907725555, 7705.537667739954], "unit": "score", "name": "mootools.html", "value": 4949.343324694879}, {"lowerIsBetter": false, "replicates": [356.88936429706786, 358.8241761536848, 368.90224090615976, 370.2779579819353, 370.8238586671333, 6032.457078862902, 6038.064100064492, 6086.573939824214, 6145.385461453852, 6152.446279834825, 5728.598998070137, 5829.621074630146, 5905.763769449217, 5947.672877991719, 6028.909566356509, 4669.439667239936, 4678.97660511697, 4680.485146633868, 4713.410823647044, 4722.929156062662, 4528.50186479487, 4699.54314162609, 4717.363155973934, 4728.716277023373, 4741.668083234175, 4558.27067669173, 4570.542945705436, 4663.0, 4676.228422310314, 4677.64917631179, 4634.467036290819, 4648.74431906245, 4651.976740116278, 4667.533246675339, 4674.368960190399, 4107.0, 4110.77390743509, 4111.60939710727, 4141.130362623852, 4148.502179738451, 5618.325800903876, 5733.140028995643, 5734.455226753452, 5748.42515748426, 5748.511376533, 5400.648957817729, 5431.293931788842, 5443.918341224885, 5445.482679145475, 5447.603054655939, 6411.3909178627955, 6431.8392040198905, 6475.320091390383, 6489.870202595969, 6491.415772580491, 4483.0, 4484.68607197493, 4486.573775491323, 4496.078303947683, 4526.841560545398, 6592.9011064833585, 6660.067590537328, 6715.496337774686, 6724.83187920301, 6733.797986060426, 4606.654500912445, 4612.100640375162, 4614.377059097046, 4617.076584683077, 4618.745968971739, 4675.1351000064415, 4677.7193368398, 4678.2280923647895, 4687.9373075846515, 4687.9765601171775, 5403.783848646089, 5406.162044883049, 5411.810586629449, 5417.26866872975, 5420.376656684532, 6351.079093531412, 6479.7408103675325, 6495.902561461582, 6500.0, 6501.284858665543, 1636.3699975509276, 1657.5110342449007, 1662.7672125902384, 1663.20166320167, 1665.017639592622, 1098.566066403766, 1102.250469680625, 1110.8278216876397, 1120.7982563138714, 1132.7564573616712, 6264.467520260829, 6272.5922815016875, 6281.340459251713, 6286.9056964145575, 6288.937110628926, 6447.548671592944, 6650.933490665128, 6670.299618540081, 6677.23211830636, 6721.731130754715, 6177.783777567854, 6224.688765561704, 6335.556511044183, 6343.777967771106, 6343.777967771106, 3547.077759782475, 3612.8916132516065, 3614.8915532534065, 3615.3492371373404, 3619.6199399063244, 6714.83212919681, 6895.379415852597, 6908.620025898524, 6921.169459664872, 6924.065251191025, 6929.133858267716, 6936.826579335557, 6944.965275173693, 6947.756828510978, 6951.617661028692, 6951.165860096719, 6953.79138625842, 6959.0, 6960.0, 6965.79102626922, 6619.933800662125, 6629.933700662931, 6631.6684165792485, 6657.900131498128, 6680.064790929371, 6598.37315455031, 6604.0, 6625.569337993015, 6626.138601981712, 6629.502787290876, 6801.489888258499, 6833.658317084027, 6853.211880633591, 6870.45036397077, 6872.244053154249, 4616.007558374966, 4690.343351930801, 4691.50739172382, 4692.53074692528, 4698.2952557116705, 6659.467242620675, 6707.631080290435, 6714.496412768965, 6717.832054198684, 6734.73061077571, 6545.6399898004165, 6571.145751052332, 6577.079208910661, 6578.276389597045, 6635.303293154149, 6509.498966433742, 6529.412352888263, 6535.607863528204, 6601.075849381186, 6612.173478315211, 6357.745690172342, 6362.840928976812, 6366.77716279928, 6370.140031095928, 6370.235571731422, 6565.277819439953, 6598.901016484852, 6629.270780214076, 6641.369069938348, 6647.268800432045, 6257.124002639725, 6374.6413826884345, 6386.201724784402, 6391.073294372383, 6393.0], "unit": "score", "name": "prototype.html", "value": 4906.354087235054}, {"lowerIsBetter": false, "replicates": [826.3100311240114, 832.4256263178406, 834.1991687979539, 903.3360480047169, 943.8395472769629, 14635.268236588168, 14713.337899794507, 14721.116732996028, 14737.70524589509, 14778.778318325234, 13512.729745405111, 15287.69424611507, 15509.612259693513, 15529.22353882307, 15565.29956151973, 705.587231469591, 876.0538618292261, 888.8400087984161, 889.1020069729555, 889.3107841422884, 718.6011763471271, 724.2865777209445, 726.7783326085541, 876.4741155306797, 882.3029806452895, 906.5557876640464, 919.7746552094712, 924.5469719837265, 927.8654595083709, 929.6142101028065, 740.3928778401713, 906.5467266366817, 909.3043821476575, 909.6952520905471, 910.426431348253, 556.1546449396894, 673.2863165045019, 677.3700458573525, 680.8331958670108, 683.2108914204102, 14591.562253132422, 14666.340014699364, 14693.632659183499, 14695.485658001919, 14696.853031469655, 13283.535076272381, 13805.309734513234, 13846.792298115537, 13892.583222503341, 13918.30408479572, 11457.614667970422, 11622.128340374506, 11769.411529423494, 11835.289882606985, 11906.642800715992, 3904.2777086239134, 3916.15802602439, 3969.2260009298197, 3971.702122340836, 3972.205558888234, 47845.0, 48384.75807620974, 53416.73291633556, 54897.725511372584, 55000.449995500334, 11174.832377514344, 11200.0, 11271.774564508827, 11282.323060616389, 11421.42892855354, 18880.0, 18885.43343699691, 19045.7143142853, 19065.0, 19093.713594296096, 8307.460015098999, 8319.417640765208, 8377.246047855722, 8522.914770852212, 8771.079036701181, 4290.206311832321, 4551.977240113778, 4597.402337696145, 4601.550511588839, 4640.767961601907, 3314.171457135716, 3335.566376371105, 3336.4995250712586, 3338.88313909012, 3346.4311067118647, 589.0604485845071, 594.2275042444891, 595.0241603769821, 598.7365559153958, 639.0382474376034, 682.5017737051979, 706.9222385537689, 713.4862898712919, 732.1763016606318, 741.280957471252, 9102.635894564144, 9110.225630821455, 9122.86315705265, 9131.041240669767, 9348.345615806964, 609.454538188319, 693.7953303775398, 752.7403045949138, 757.2654525110634, 761.4365369626437, 4384.583464570861, 4388.978055109704, 4439.311906654474, 4442.666799990014, 4555.134524440346, 63673.0, 64427.0, 64525.677371612845, 64586.35413645898, 64628.35371646317, 56834.7158264206, 56877.431225688044, 56892.43107568871, 56945.145822812694, 57013.0, 49165.508344916096, 49174.99999999929, 50091.24863127056, 50774.23838642424, 50823.49176508262, 8833.911660883308, 8977.192052715025, 9036.0, 9060.414427475298, 9193.770155745893, 35546.644533555365, 35813.0, 36380.81809590935, 37051.25897482089, 37642.05894852651, 43754.781226094936, 48097.519024809306, 48413.757931210115, 51027.0, 51176.74411627918, 11870.406479676154, 12169.452374642986, 12234.204776689487, 12413.813792793297, 12474.563390281659, 12625.368731563569, 12849.678758031125, 13149.53976610814, 13243.735125297248, 13297.534586289821, 12470.875291246972, 12515.687107822014, 12520.87479125197, 12832.422540985865, 12903.935480322538, 12476.688082798002, 12630.684232894251, 12658.810117848423, 12680.365981700694, 12860.935695321463, 11432.657020289405, 12452.56416025471, 12612.432440540015, 13249.337533123113, 13541.932290338485, 9974.800503989734, 10089.596416143271, 10228.53971571296, 10302.433366164933, 10361.222908281758, 9886.703398898044, 10076.748081298027, 10252.43611601369, 10337.9483102584, 10348.22388320894], "unit": "score", "name": "yui.html", "value": 6834.114072286706}], "name": "dromaeo_css", "value": 7216.588011097331}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 110.0, 111.0, 110.0, 101.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 128.0, 158.0, 167.0, 131.0, 149.0, 153.0, 132.0, 162.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 161.0, 161.0, 161.0, 159.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 74.0, 142.0, 75.0, 73.0, 79.0, 73.0, 154.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 149.0, 95.0, 95.0, 95.0, 134.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 54.0, 56.0, 53.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 78.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 86.0, 79.0, 88.0, 85.0, 80.0, 78.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [117.0, 109.0, 110.0, 117.0, 117.0, 113.0, 115.0, 111.0, 112.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [135.0, 126.0, 129.0, 134.0, 140.0, 129.0, 147.0, 135.0, 136.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 63.0, 65.0, 64.0, 66.0, 65.0, 64.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1473.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [170.38677798602828], "unit": "score", "name": "DeltaBlue", "value": 388.0465419999999}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [557.4136008918617], "unit": "score", "name": "Earley", "value": 1195.6346220000003}, {"lowerIsBetter": false, "replicates": [10765.95744680851], "unit": "score", "name": "Boyer", "value": 61.90466600790514}, {"lowerIsBetter": false, "replicates": [39921.56862745098], "unit": "score", "name": "RegExp", "value": 22.819368860510817}, {"lowerIsBetter": false, "replicates": [520.8333333333334], "unit": "score", "name": "Splay", "value": 156.46272000000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21986.149914139303}]} 11:29:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "21986.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1473.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7216.59"}}} 11:29:04 INFO - Return code: 0 11:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:04 INFO - # TBPL SUCCESS # 11:29:04 INFO - Running post-action listener: _resource_record_post_action 11:29:04 INFO - Running post-run listener: _resource_record_post_run 11:29:05 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 462172160; Read time: 0; Write time: 272608 11:29:05 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234430464; Read time: 0; Write time: 179312 11:29:05 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 227741696; Read time: 0; Write time: 93296 11:29:05 INFO - Running post-run listener: _upload_blobber_files 11:29:05 INFO - Blob upload gear active. 11:29:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:05 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 11:29:05 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:05 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:07 INFO - (blobuploader) - INFO - Done attempting. 11:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:08 INFO - (blobuploader) - INFO - Done attempting. 11:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:08 INFO - Return code: 0 11:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/028fe03da3f94c326eee6c3ecc4d6c10fac15605ea1283e1e73e792faa2f514c78d041f89862b5cb2941260e91cda0bf1128d8d93fb02d660a60375fdcf6ea72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bfe19bd658e17b4697fb1b1bcb6030e8326f431fa55c10bd31bff08c9b4e77189e84c4bab3f05d380a370208712e217b64eafe2a2cce0254d43f56c9d3d895e7"} 11:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:08 INFO - Contents: 11:29:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/028fe03da3f94c326eee6c3ecc4d6c10fac15605ea1283e1e73e792faa2f514c78d041f89862b5cb2941260e91cda0bf1128d8d93fb02d660a60375fdcf6ea72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bfe19bd658e17b4697fb1b1bcb6030e8326f431fa55c10bd31bff08c9b4e77189e84c4bab3f05d380a370208712e217b64eafe2a2cce0254d43f56c9d3d895e7"} 11:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:08 INFO - Copying logs to upload dir... 11:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.683643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-11 11:29:07.907812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 11:29:07.911314) ========= 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/028fe03da3f94c326eee6c3ecc4d6c10fac15605ea1283e1e73e792faa2f514c78d041f89862b5cb2941260e91cda0bf1128d8d93fb02d660a60375fdcf6ea72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bfe19bd658e17b4697fb1b1bcb6030e8326f431fa55c10bd31bff08c9b4e77189e84c4bab3f05d380a370208712e217b64eafe2a2cce0254d43f56c9d3d895e7"} build_url:https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/a9PepflnSNmffcgwwOcJ1w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/028fe03da3f94c326eee6c3ecc4d6c10fac15605ea1283e1e73e792faa2f514c78d041f89862b5cb2941260e91cda0bf1128d8d93fb02d660a60375fdcf6ea72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/bfe19bd658e17b4697fb1b1bcb6030e8326f431fa55c10bd31bff08c9b4e77189e84c4bab3f05d380a370208712e217b64eafe2a2cce0254d43f56c9d3d895e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 11:29:07.935508) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:29:07.935799) ========= 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=7cf709767345e0a0c5a90e72000001d4-1457721839.957019-1150770814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:29:08.018539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 11:29:08.018842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 11:29:08.019147) ========= ========= Total master_lag: 0.27 =========