builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1486256689.44 results: success (0) revision: e581572bc9c128df28d3f97698d83f9b3c459da5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.437650) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.438084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.438376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.456527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.456915) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-04 17:04:49-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.5M=0s 2017-02-04 17:04:49 (89.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.816879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.817197) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013201 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.866549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:49.866908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e581572bc9c128df28d3f97698d83f9b3c459da5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev e581572bc9c128df28d3f97698d83f9b3c459da5 --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=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-04 17:04:50,058 truncating revision to first 12 chars 2017-02-04 17:04:50,058 Setting DEBUG logging. 2017-02-04 17:04:50,058 attempt 1/10 2017-02-04 17:04:50,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e581572bc9c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 17:04:50,359 unpacking tar archive at: mozilla-central-e581572bc9c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:50.488403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:50.488722) ========= script_repo_revision: e581572bc9c128df28d3f97698d83f9b3c459da5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:50.489102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:50.489443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 17:04:50.498428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-02-04 17:04:50.498865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:50 INFO - MultiFileLogger online at 20170204 17:04:50 in /builds/slave/test 17:04:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:04:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:04:50 INFO - {'append_to_log': False, 17:04:50 INFO - 'base_work_dir': '/builds/slave/test', 17:04:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:04:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:04:50 INFO - 'branch': 'Firefox-Non-PGO', 17:04:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:50 INFO - 'config_files': ('talos/linux_config.py',), 17:04:50 INFO - 'default_actions': ('clobber', 17:04:50 INFO - 'read-buildbot-config', 17:04:50 INFO - 'download-and-extract', 17:04:50 INFO - 'populate-webroot', 17:04:50 INFO - 'create-virtualenv', 17:04:50 INFO - 'install', 17:04:50 INFO - 'run-tests'), 17:04:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:50 INFO - 'download_minidump_stackwalk': True, 17:04:50 INFO - 'download_symbols': 'ondemand', 17:04:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:50 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:50 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:50 INFO - 'installer_path': 'installer.exe', 17:04:50 INFO - 'log_level': 'info', 17:04:50 INFO - 'log_name': 'talos', 17:04:50 INFO - 'log_to_console': True, 17:04:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:50 INFO - 'opt_config_files': (), 17:04:50 INFO - 'pip_index': False, 17:04:50 INFO - 'sps_profile': False, 17:04:50 INFO - 'sps_profile_interval': 0, 17:04:50 INFO - 'suite': 'dromaeojs-e10s', 17:04:50 INFO - 'system_bits': '32', 17:04:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:50 INFO - 'title': 'talos-linux64-ix-029', 17:04:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:50 INFO - 'use_talos_json': True, 17:04:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:04:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:50 INFO - 'work_dir': 'build'} 17:04:50 INFO - [mozharness: 2017-02-05 01:04:50.784321Z] Running clobber step. 17:04:50 INFO - Running pre-action listener: _resource_record_pre_action 17:04:50 INFO - Running main action method: clobber 17:04:50 INFO - rmtree: /builds/slave/test/build 17:04:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:04:51 INFO - Running post-action listener: _resource_record_post_action 17:04:51 INFO - [mozharness: 2017-02-05 01:04:51.235588Z] Finished clobber step (success) 17:04:51 INFO - [mozharness: 2017-02-05 01:04:51.235692Z] Running read-buildbot-config step. 17:04:51 INFO - Running pre-action listener: _resource_record_pre_action 17:04:51 INFO - Running main action method: read_buildbot_config 17:04:51 INFO - Using buildbot properties: 17:04:51 INFO - { 17:04:51 INFO - "project": "", 17:04:51 INFO - "product": "firefox", 17:04:51 INFO - "who": "philringnalda@gmail.com", 17:04:51 INFO - "installer_path": "public/build/target.tar.bz2", 17:04:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:04:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:04:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:04:51 INFO - "stage_platform": "linux64", 17:04:51 INFO - "basedir": "/builds/slave/test", 17:04:51 INFO - "buildnumber": 684, 17:04:51 INFO - "platform": "ubuntu64_hw", 17:04:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:04:51 INFO - "slavebuilddir": "test", 17:04:51 INFO - "taskId": "K_4z8_-hQnqDn1S3-WmR6g", 17:04:51 INFO - "branch": "mozilla-central", 17:04:51 INFO - "script_repo_revision": "production", 17:04:51 INFO - "revision": "e581572bc9c128df28d3f97698d83f9b3c459da5", 17:04:51 INFO - "slavename": "talos-linux64-ix-029", 17:04:51 INFO - "repo_path": "mozilla-central" 17:04:51 INFO - } 17:04:51 INFO - Finding installer, test and symbols from parent task. 17:04:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_4z8_-hQnqDn1S3-WmR6g'}, attempt #1 17:04:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_4z8_-hQnqDn1S3-WmR6g'}, attempt #1 17:04:52 INFO - Task dependencies: S0WmBJt4SWyTK4qG7sUsJQ 17:04:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ'}, attempt #1 17:04:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 17:04:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/test_packages.json 17:04:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.crashreporter-symbols.zip 17:04:52 INFO - Running post-action listener: _resource_record_post_action 17:04:52 INFO - [mozharness: 2017-02-05 01:04:52.607498Z] Finished read-buildbot-config step (success) 17:04:52 INFO - [mozharness: 2017-02-05 01:04:52.607760Z] Running download-and-extract step. 17:04:52 INFO - Running pre-action listener: _resource_record_pre_action 17:04:52 INFO - Running main action method: download_and_extract 17:04:52 INFO - mkdir: /builds/slave/test/build/tests 17:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:52 INFO - trying https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.test_packages.json 17:04:52 INFO - Downloading https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:04:53 INFO - Downloaded 896 bytes. 17:04:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:04:53 INFO - Using the following test package requirements: 17:04:53 INFO - {u'common': [u'target.common.tests.zip'], 17:04:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:04:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:04:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:04:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:04:53 INFO - u'mozbase': [u'target.common.tests.zip'], 17:04:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:04:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:04:53 INFO - u'web-platform': [u'target.common.tests.zip', 17:04:53 INFO - u'target.web-platform.tests.zip'], 17:04:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:04:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:04:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip 17:04:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:04:53 INFO - Fetch https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip into memory 17:04:54 INFO - Expected file size: 39902302 17:04:54 INFO - Obtained file size: 39902302 17:04:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:04:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip 17:04:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:04:58 INFO - Fetch https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.common.tests.zip into memory 17:05:00 INFO - Expected file size: 39902302 17:05:00 INFO - Obtained file size: 39902302 17:05:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.talos.tests.zip 17:05:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:05:05 INFO - Fetch https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.talos.tests.zip into memory 17:05:06 INFO - Expected file size: 14403454 17:05:06 INFO - Obtained file size: 14403454 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:06 INFO - trying https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 17:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:05:08 INFO - Downloaded 56252452 bytes. 17:05:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 17:05:08 INFO - mkdir: /builds/slave/test/properties 17:05:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:05:08 INFO - Writing to file /builds/slave/test/properties/build_url 17:05:08 INFO - Contents: 17:05:08 INFO - build_url:https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 17:05:08 INFO - Running post-action listener: _resource_record_post_action 17:05:08 INFO - Running post-action listener: set_extra_try_arguments 17:05:08 INFO - [mozharness: 2017-02-05 01:05:08.960048Z] Finished download-and-extract step (success) 17:05:08 INFO - [mozharness: 2017-02-05 01:05:08.960274Z] Running populate-webroot step. 17:05:08 INFO - Running pre-action listener: _resource_record_pre_action 17:05:08 INFO - Running main action method: populate_webroot 17:05:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:05:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:05:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:05:08 INFO - '--tppagecycles', 17:05:08 INFO - '7'], 17:05:08 INFO - 'tests': ['tsvgm']}}, 17:05:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:05:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:05:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:05:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:05:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:05:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:05:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['damp', 'tps']}, 17:05:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'tests': ['damp', 'tps']}, 17:05:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['dromaeo_dom']}, 17:05:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:05:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['basic_compositor_video']}, 17:05:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:05:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'other-e10s': {'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['a11yr', 17:05:08 INFO - 'ts_paint', 17:05:08 INFO - 'tpaint', 17:05:08 INFO - 'sessionrestore', 17:05:08 INFO - 'sessionrestore_no_auto_restore', 17:05:08 INFO - 'tabpaint']}, 17:05:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['tsvgx', 17:05:08 INFO - 'tsvgr_opacity', 17:05:08 INFO - 'tart', 17:05:08 INFO - 'tscrollx', 17:05:08 INFO - 'cart', 17:05:08 INFO - 'tsvg_static']}, 17:05:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:05:08 INFO - 'tsvgr_opacity', 17:05:08 INFO - 'tart', 17:05:08 INFO - 'tscrollx', 17:05:08 INFO - 'cart', 17:05:08 INFO - 'tsvg_static']}, 17:05:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'talos_options': ['--disable-e10s'], 17:05:08 INFO - 'tests': ['tp5o']}, 17:05:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:05:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'talos_options': ['--disable-e10s', 17:05:08 INFO - '--xperf_path', 17:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:05:08 INFO - 'tests': ['tp5n']}, 17:05:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:05:08 INFO - 'talos_options': ['--xperf_path', 17:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:05:08 INFO - 'tests': ['tp5n']}}, 17:05:08 INFO - 'talos.zip': {'path': '', 17:05:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:05:08 INFO - Running post-action listener: _resource_record_post_action 17:05:08 INFO - [mozharness: 2017-02-05 01:05:08.980530Z] Finished populate-webroot step (success) 17:05:08 INFO - [mozharness: 2017-02-05 01:05:08.980621Z] Running create-virtualenv step. 17:05:08 INFO - Running pre-action listener: _resource_record_pre_action 17:05:08 INFO - Running main action method: create_virtualenv 17:05:08 INFO - Creating virtualenv /builds/slave/test/build/venv 17:05:08 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 17:05:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:05:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:05:09 INFO - Using real prefix '/usr' 17:05:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:05:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:05:11 INFO - Installing pip.................done. 17:05:11 INFO - Return code: 0 17:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:05:11 INFO - Reading from file tmpfile_stdout 17:05:11 INFO - Output received: 17:05:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:05:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:05:11 INFO - Using env: {'DISPLAY': ':0', 17:05:11 INFO - 'HOME': '/home/cltbld', 17:05:11 INFO - 'LANG': 'en_US.UTF-8', 17:05:11 INFO - 'LANGUAGE': 'en_US:en', 17:05:11 INFO - 'LOGNAME': 'cltbld', 17:05:11 INFO - 'MAIL': '/var/mail/cltbld', 17:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:11 INFO - 'MOZ_NO_REMOTE': '1', 17:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:11 INFO - 'NO_EM_RESTART': '1', 17:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:11 INFO - 'PWD': '/builds/slave/test', 17:05:11 INFO - 'SHELL': '/bin/bash', 17:05:11 INFO - 'SHLVL': '1', 17:05:11 INFO - 'TERM': 'linux', 17:05:11 INFO - 'TMOUT': '86400', 17:05:11 INFO - 'USER': 'cltbld', 17:05:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:11 INFO - '_': '/tools/buildbot/bin/python'} 17:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:11 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 17:05:11 INFO - Cleaning up... 17:05:11 INFO - Return code: 0 17:05:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:05:11 INFO - Using env: {'DISPLAY': ':0', 17:05:11 INFO - 'HOME': '/home/cltbld', 17:05:11 INFO - 'LANG': 'en_US.UTF-8', 17:05:11 INFO - 'LANGUAGE': 'en_US:en', 17:05:11 INFO - 'LOGNAME': 'cltbld', 17:05:11 INFO - 'MAIL': '/var/mail/cltbld', 17:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:11 INFO - 'MOZ_NO_REMOTE': '1', 17:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:11 INFO - 'NO_EM_RESTART': '1', 17:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:11 INFO - 'PWD': '/builds/slave/test', 17:05:11 INFO - 'SHELL': '/bin/bash', 17:05:11 INFO - 'SHLVL': '1', 17:05:11 INFO - 'TERM': 'linux', 17:05:11 INFO - 'TMOUT': '86400', 17:05:11 INFO - 'USER': 'cltbld', 17:05:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:11 INFO - '_': '/tools/buildbot/bin/python'} 17:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:12 INFO - Downloading/unpacking psutil>=3.1.1 17:05:12 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 17:05:12 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 17:05:12 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 17:05:12 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 17:05:12 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 17:05:12 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 17:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:05:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:14 INFO - Installing collected packages: psutil 17:05:14 INFO - Running setup.py install for psutil 17:05:14 INFO - building 'psutil._psutil_linux' extension 17:05:14 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 17:05:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:05:14 INFO - building 'psutil._psutil_posix' extension 17:05:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:05:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:05:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:14 INFO - Successfully installed psutil 17:05:14 INFO - Cleaning up... 17:05:14 INFO - Return code: 0 17:05:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:05:14 INFO - Using env: {'DISPLAY': ':0', 17:05:14 INFO - 'HOME': '/home/cltbld', 17:05:14 INFO - 'LANG': 'en_US.UTF-8', 17:05:14 INFO - 'LANGUAGE': 'en_US:en', 17:05:14 INFO - 'LOGNAME': 'cltbld', 17:05:14 INFO - 'MAIL': '/var/mail/cltbld', 17:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:14 INFO - 'MOZ_NO_REMOTE': '1', 17:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:14 INFO - 'NO_EM_RESTART': '1', 17:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:14 INFO - 'PWD': '/builds/slave/test', 17:05:14 INFO - 'SHELL': '/bin/bash', 17:05:14 INFO - 'SHLVL': '1', 17:05:14 INFO - 'TERM': 'linux', 17:05:14 INFO - 'TMOUT': '86400', 17:05:14 INFO - 'USER': 'cltbld', 17:05:14 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:14 INFO - '_': '/tools/buildbot/bin/python'} 17:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:05:15 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 17:05:15 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 17:05:15 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 17:05:15 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 17:05:15 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 17:05:15 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 17:05:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:05:17 INFO - Installing collected packages: mozsystemmonitor 17:05:17 INFO - Running setup.py install for mozsystemmonitor 17:05:17 INFO - Successfully installed mozsystemmonitor 17:05:17 INFO - Cleaning up... 17:05:17 INFO - Return code: 0 17:05:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:05:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:05:17 INFO - Using env: {'DISPLAY': ':0', 17:05:17 INFO - 'HOME': '/home/cltbld', 17:05:17 INFO - 'LANG': 'en_US.UTF-8', 17:05:17 INFO - 'LANGUAGE': 'en_US:en', 17:05:17 INFO - 'LOGNAME': 'cltbld', 17:05:17 INFO - 'MAIL': '/var/mail/cltbld', 17:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:17 INFO - 'MOZ_NO_REMOTE': '1', 17:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:17 INFO - 'NO_EM_RESTART': '1', 17:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:17 INFO - 'PWD': '/builds/slave/test', 17:05:17 INFO - 'SHELL': '/bin/bash', 17:05:17 INFO - 'SHLVL': '1', 17:05:17 INFO - 'TERM': 'linux', 17:05:17 INFO - 'TMOUT': '86400', 17:05:17 INFO - 'USER': 'cltbld', 17:05:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:17 INFO - '_': '/tools/buildbot/bin/python'} 17:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:05:19 INFO - warning: no files found matching '*.txt' 17:05:19 INFO - no previously-included directories found matching 'build' 17:05:19 INFO - no previously-included directories found matching 'dist' 17:05:19 INFO - no previously-included directories found matching '.git*' 17:05:19 INFO - Installing collected packages: jsonschema, functools32 17:05:19 INFO - Running setup.py install for functools32 17:05:19 INFO - warning: no files found matching '*.txt' 17:05:19 INFO - no previously-included directories found matching 'build' 17:05:19 INFO - no previously-included directories found matching 'dist' 17:05:19 INFO - no previously-included directories found matching '.git*' 17:05:19 INFO - Successfully installed jsonschema functools32 17:05:19 INFO - Cleaning up... 17:05:19 INFO - Return code: 0 17:05:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:05:19 INFO - Using env: {'DISPLAY': ':0', 17:05:19 INFO - 'HOME': '/home/cltbld', 17:05:19 INFO - 'LANG': 'en_US.UTF-8', 17:05:19 INFO - 'LANGUAGE': 'en_US:en', 17:05:19 INFO - 'LOGNAME': 'cltbld', 17:05:19 INFO - 'MAIL': '/var/mail/cltbld', 17:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:19 INFO - 'MOZ_NO_REMOTE': '1', 17:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:19 INFO - 'NO_EM_RESTART': '1', 17:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:19 INFO - 'PWD': '/builds/slave/test', 17:05:19 INFO - 'SHELL': '/bin/bash', 17:05:19 INFO - 'SHLVL': '1', 17:05:19 INFO - 'TERM': 'linux', 17:05:19 INFO - 'TMOUT': '86400', 17:05:19 INFO - 'USER': 'cltbld', 17:05:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:19 INFO - '_': '/tools/buildbot/bin/python'} 17:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:05:20 INFO - Cleaning up... 17:05:20 INFO - Return code: 0 17:05:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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', '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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:05: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 blobuploader==1.2.4 17:05:20 INFO - Using env: {'DISPLAY': ':0', 17:05:20 INFO - 'HOME': '/home/cltbld', 17:05:20 INFO - 'LANG': 'en_US.UTF-8', 17:05:20 INFO - 'LANGUAGE': 'en_US:en', 17:05:20 INFO - 'LOGNAME': 'cltbld', 17:05:20 INFO - 'MAIL': '/var/mail/cltbld', 17:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:20 INFO - 'MOZ_NO_REMOTE': '1', 17:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:20 INFO - 'NO_EM_RESTART': '1', 17:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:20 INFO - 'PWD': '/builds/slave/test', 17:05:20 INFO - 'SHELL': '/bin/bash', 17:05:20 INFO - 'SHLVL': '1', 17:05:20 INFO - 'TERM': 'linux', 17:05:20 INFO - 'TMOUT': '86400', 17:05:20 INFO - 'USER': 'cltbld', 17:05:20 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:20 INFO - '_': '/tools/buildbot/bin/python'} 17:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:05:20 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 17:05:20 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 17:05:20 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 17:05:20 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 17:05:20 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 17:05:20 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 17:05:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:05:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:05:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:23 INFO - Downloading docopt-0.6.1.tar.gz 17:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:05:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:05:23 INFO - Running setup.py install for blobuploader 17:05:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:05:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:05:23 INFO - Running setup.py install for requests 17:05:23 INFO - Running setup.py install for docopt 17:05:23 INFO - Successfully installed blobuploader requests docopt 17:05:23 INFO - Cleaning up... 17:05:23 INFO - Return code: 0 17:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:23 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:23 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 17:05:23 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 17:05:23 INFO - Using env: {'DISPLAY': ':0', 17:05:23 INFO - 'HOME': '/home/cltbld', 17:05:23 INFO - 'LANG': 'en_US.UTF-8', 17:05:23 INFO - 'LANGUAGE': 'en_US:en', 17:05:23 INFO - 'LOGNAME': 'cltbld', 17:05:23 INFO - 'MAIL': '/var/mail/cltbld', 17:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:23 INFO - 'MOZ_NO_REMOTE': '1', 17:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:23 INFO - 'NO_EM_RESTART': '1', 17:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:23 INFO - 'PWD': '/builds/slave/test', 17:05:23 INFO - 'SHELL': '/bin/bash', 17:05:23 INFO - 'SHLVL': '1', 17:05:23 INFO - 'TERM': 'linux', 17:05:23 INFO - 'TMOUT': '86400', 17:05:23 INFO - 'USER': 'cltbld', 17:05:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:23 INFO - '_': '/tools/buildbot/bin/python'} 17:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:05:24 INFO - Running setup.py (path:/tmp/pip-OB4bOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:05:24 INFO - Running setup.py (path:/tmp/pip-bYIvis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:05:24 INFO - Running setup.py (path:/tmp/pip-xY0eZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:24 INFO - Running setup.py (path:/tmp/pip-5JFXSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:24 INFO - Running setup.py (path:/tmp/pip-soxsfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:24 INFO - Running setup.py (path:/tmp/pip-077b9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:24 INFO - Running setup.py (path:/tmp/pip-0daRQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:24 INFO - Running setup.py (path:/tmp/pip-RfED9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:24 INFO - Running setup.py (path:/tmp/pip-vah5_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:24 INFO - Running setup.py (path:/tmp/pip-TEch79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:24 INFO - Running setup.py (path:/tmp/pip-T8YEc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:24 INFO - Running setup.py (path:/tmp/pip-F_Ah7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:24 INFO - Running setup.py (path:/tmp/pip-QTHhnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:24 INFO - Running setup.py (path:/tmp/pip-9C0tRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:25 INFO - Running setup.py (path:/tmp/pip-MQiojI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:25 INFO - Running setup.py (path:/tmp/pip-vPTOTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:25 INFO - Running setup.py (path:/tmp/pip-4Wn4LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:05:25 INFO - Running setup.py install for manifestparser 17:05:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:05:25 INFO - Running setup.py install for mozcrash 17:05:25 INFO - Running setup.py install for mozdebug 17:05:25 INFO - Running setup.py install for mozdevice 17:05:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:05:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:05:25 INFO - Running setup.py install for mozfile 17:05:25 INFO - Running setup.py install for mozhttpd 17:05:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:05:25 INFO - Running setup.py install for mozinfo 17:05:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:05:25 INFO - Running setup.py install for mozInstall 17:05:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Running setup.py install for mozleak 17:05:26 INFO - Running setup.py install for mozlog 17:05:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Running setup.py install for moznetwork 17:05:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Running setup.py install for mozprocess 17:05:26 INFO - Running setup.py install for mozprofile 17:05:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Running setup.py install for mozrunner 17:05:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Running setup.py install for mozscreenshot 17:05:26 INFO - Running setup.py install for moztest 17:05:26 INFO - Running setup.py install for mozversion 17:05:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:05:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:05:26 INFO - Cleaning up... 17:05:26 INFO - Return code: 0 17:05:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:27 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:27 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 17:05:27 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 17:05:27 INFO - Using env: {'DISPLAY': ':0', 17:05:27 INFO - 'HOME': '/home/cltbld', 17:05:27 INFO - 'LANG': 'en_US.UTF-8', 17:05:27 INFO - 'LANGUAGE': 'en_US:en', 17:05:27 INFO - 'LOGNAME': 'cltbld', 17:05:27 INFO - 'MAIL': '/var/mail/cltbld', 17:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:27 INFO - 'MOZ_NO_REMOTE': '1', 17:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:27 INFO - 'NO_EM_RESTART': '1', 17:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:27 INFO - 'PWD': '/builds/slave/test', 17:05:27 INFO - 'SHELL': '/bin/bash', 17:05:27 INFO - 'SHLVL': '1', 17:05:27 INFO - 'TERM': 'linux', 17:05:27 INFO - 'TMOUT': '86400', 17:05:27 INFO - 'USER': 'cltbld', 17:05:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:27 INFO - '_': '/tools/buildbot/bin/python'} 17:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:05:27 INFO - Running setup.py (path:/tmp/pip-eTK_Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:05:27 INFO - Running setup.py (path:/tmp/pip-I38uDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:05:27 INFO - Running setup.py (path:/tmp/pip-nGUd3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:27 INFO - Running setup.py (path:/tmp/pip-SGVftU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:27 INFO - Running setup.py (path:/tmp/pip-E6TxJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:27 INFO - Running setup.py (path:/tmp/pip-Pyzdxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:27 INFO - Running setup.py (path:/tmp/pip-comIz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:27 INFO - Running setup.py (path:/tmp/pip-VC5es3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:27 INFO - Running setup.py (path:/tmp/pip-rixL5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:27 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:27 INFO - Running setup.py (path:/tmp/pip-tnG9Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 17:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:27 INFO - Running setup.py (path:/tmp/pip-QJBEgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:28 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:28 INFO - Running setup.py (path:/tmp/pip-MiWusG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:28 INFO - Running setup.py (path:/tmp/pip-anSUOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:28 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:28 INFO - Running setup.py (path:/tmp/pip-y9zUqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:28 INFO - Running setup.py (path:/tmp/pip-_sKtu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:28 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:28 INFO - Running setup.py (path:/tmp/pip-dY7_GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 17:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:28 INFO - Running setup.py (path:/tmp/pip-6XBPFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:28 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)) 17:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:28 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)) 17:05:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:30 INFO - Downloading blessings-1.6.tar.gz 17:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:05:30 INFO - Installing collected packages: blessings 17:05:30 INFO - Running setup.py install for blessings 17:05:30 INFO - Successfully installed blessings 17:05:30 INFO - Cleaning up... 17:05:30 INFO - Return code: 0 17:05:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:30 INFO - Reading from file tmpfile_stdout 17:05:30 INFO - Current package versions: 17:05:30 INFO - argparse == 1.2.1 17:05:30 INFO - blessings == 1.6 17:05:30 INFO - blobuploader == 1.2.4 17:05:30 INFO - docopt == 0.6.1 17:05:30 INFO - functools32 == 3.2.3-2 17:05:30 INFO - jsonschema == 2.5.1 17:05:30 INFO - manifestparser == 1.1 17:05:30 INFO - mozInstall == 1.12 17:05:30 INFO - mozcrash == 1.0 17:05:30 INFO - mozdebug == 0.1 17:05:30 INFO - mozdevice == 0.49 17:05:30 INFO - mozfile == 1.2 17:05:30 INFO - mozhttpd == 0.7 17:05:30 INFO - mozinfo == 0.9 17:05:30 INFO - mozleak == 0.1 17:05:30 INFO - mozlog == 3.4 17:05:30 INFO - moznetwork == 0.27 17:05:30 INFO - mozprocess == 0.24 17:05:30 INFO - mozprofile == 0.28 17:05:30 INFO - mozrunner == 6.13 17:05:30 INFO - mozscreenshot == 0.1 17:05:30 INFO - mozsystemmonitor == 0.3 17:05:30 INFO - moztest == 0.8 17:05:30 INFO - mozversion == 1.4 17:05:30 INFO - psutil == 3.1.1 17:05:30 INFO - requests == 1.2.3 17:05:30 INFO - wsgiref == 0.1.2 17:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:30 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:30 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 17:05:30 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 17:05:30 INFO - Using env: {'DISPLAY': ':0', 17:05:30 INFO - 'HOME': '/home/cltbld', 17:05:30 INFO - 'LANG': 'en_US.UTF-8', 17:05:30 INFO - 'LANGUAGE': 'en_US:en', 17:05:30 INFO - 'LOGNAME': 'cltbld', 17:05:30 INFO - 'MAIL': '/var/mail/cltbld', 17:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:30 INFO - 'MOZ_NO_REMOTE': '1', 17:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:30 INFO - 'NO_EM_RESTART': '1', 17:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:30 INFO - 'PWD': '/builds/slave/test', 17:05:30 INFO - 'SHELL': '/bin/bash', 17:05:30 INFO - 'SHLVL': '1', 17:05:30 INFO - 'TERM': 'linux', 17:05:30 INFO - 'TMOUT': '86400', 17:05:30 INFO - 'USER': 'cltbld', 17:05:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:30 INFO - '_': '/tools/buildbot/bin/python'} 17:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 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)) 17:05:31 INFO - Cleaning up... 17:05:31 INFO - Return code: 0 17:05:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:05:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:31 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 0x1b6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edc480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', '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 17:05:31 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 17:05:31 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 17:05:31 INFO - Using env: {'DISPLAY': ':0', 17:05:31 INFO - 'HOME': '/home/cltbld', 17:05:31 INFO - 'LANG': 'en_US.UTF-8', 17:05:31 INFO - 'LANGUAGE': 'en_US:en', 17:05:31 INFO - 'LOGNAME': 'cltbld', 17:05:31 INFO - 'MAIL': '/var/mail/cltbld', 17:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:31 INFO - 'MOZ_NO_REMOTE': '1', 17:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:31 INFO - 'NO_EM_RESTART': '1', 17:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:31 INFO - 'PWD': '/builds/slave/test', 17:05:31 INFO - 'SHELL': '/bin/bash', 17:05:31 INFO - 'SHLVL': '1', 17:05:31 INFO - 'TERM': 'linux', 17:05:31 INFO - 'TMOUT': '86400', 17:05:31 INFO - 'USER': 'cltbld', 17:05:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:31 INFO - '_': '/tools/buildbot/bin/python'} 17:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:05:31 INFO - Cleaning up... 17:05:31 INFO - Return code: 0 17:05:31 INFO - Running post-action listener: _resource_record_post_action 17:05:31 INFO - Running post-action listener: _start_resource_monitoring 17:05:31 INFO - Starting resource monitoring. 17:05:31 INFO - [mozharness: 2017-02-05 01:05:31.429487Z] Finished create-virtualenv step (success) 17:05:31 INFO - [mozharness: 2017-02-05 01:05:31.429973Z] Running install step. 17:05:31 INFO - Running pre-action listener: _resource_record_pre_action 17:05:31 INFO - Running main action method: install 17:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:31 INFO - Reading from file tmpfile_stdout 17:05:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:05:31 INFO - Reading from file tmpfile_stdout 17:05:31 INFO - Output received: 17:05:31 INFO - Usage: mozinstall [options] installer 17:05:31 INFO - Options: 17:05:31 INFO - -h, --help show this help message and exit 17:05:31 INFO - -d DEST, --destination=DEST 17:05:31 INFO - Directory to install application into. [default: 17:05:31 INFO - "/builds/slave/test"] 17:05:31 INFO - --app=APP Application being installed. [default: firefox] 17:05:31 INFO - mkdir: /builds/slave/test/build/application 17:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:05:47 INFO - Reading from file tmpfile_stdout 17:05:47 INFO - Output received: 17:05:47 INFO - /builds/slave/test/build/application/firefox/firefox 17:05:47 INFO - Running post-action listener: _resource_record_post_action 17:05:47 INFO - [mozharness: 2017-02-05 01:05:47.947043Z] Finished install step (success) 17:05:47 INFO - [mozharness: 2017-02-05 01:05:47.947190Z] Running run-tests step. 17:05:47 INFO - Running pre-action listener: _resource_record_pre_action 17:05:47 INFO - Running main action method: run_tests 17:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:05:47 INFO - Python 2.7.3 17:05:47 INFO - Return code: 0 17:05:47 INFO - grabbing minidump binary from tooltool 17:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9820>, '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 0x1eda520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eda9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:05:47 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 17:05:47 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 17:05:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:05:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:48 INFO - Return code: 0 17:05:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:05:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:05:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:05:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:05:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:05:48 INFO - Using env: {'DISPLAY': ':0', 17:05:48 INFO - 'HOME': '/home/cltbld', 17:05:48 INFO - 'LANG': 'en_US.UTF-8', 17:05:48 INFO - 'LANGUAGE': 'en_US:en', 17:05:48 INFO - 'LOGNAME': 'cltbld', 17:05:48 INFO - 'MAIL': '/var/mail/cltbld', 17:05:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:05:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:48 INFO - 'MOZ_NO_REMOTE': '1', 17:05:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:48 INFO - 'NO_EM_RESTART': '1', 17:05:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:48 INFO - 'PWD': '/builds/slave/test', 17:05:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:05:48 INFO - 'SHELL': '/bin/bash', 17:05:48 INFO - 'SHLVL': '1', 17:05:48 INFO - 'TERM': 'linux', 17:05:48 INFO - 'TMOUT': '86400', 17:05:48 INFO - 'USER': 'cltbld', 17:05:48 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861', 17:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:48 INFO - '_': '/tools/buildbot/bin/python'} 17:05:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:05:48 INFO - mozversion application_buildid: 20170205003657 17:05:48 INFO - mozversion application_changeset: e581572bc9c128df28d3f97698d83f9b3c459da5 17:05:48 INFO - mozversion application_display_name: Nightly 17:05:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:48 INFO - mozversion application_name: Firefox 17:05:48 INFO - mozversion application_remotingname: firefox 17:05:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:05:48 INFO - mozversion application_vendor: Mozilla 17:05:48 INFO - mozversion application_version: 54.0a1 17:05:48 INFO - mozversion platform_buildid: 20170205003657 17:05:48 INFO - mozversion platform_changeset: e581572bc9c128df28d3f97698d83f9b3c459da5 17:05:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:05:48 INFO - mozversion platform_version: 54.0a1 17:05:48 INFO - using testdate: 1486256748 17:05:48 INFO - actual date: 1486256748 17:05:48 INFO - starting webserver on 'localhost:35707' 17:05:48 INFO - SUITE-START | Running 2 tests 17:05:48 INFO - TEST-START | dromaeo_css 17:05:48 INFO - operating with platform_type : linux_ 17:05:48 INFO - Initialising browser for dromaeo_css test... 17:05:48 INFO - TEST-INFO | started process 6971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXe_doi/profile http://localhost:35707/getInfo.html) 17:05:53 INFO - PROCESS | 6971 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:05:53 INFO - PROCESS | 6971 | __metrics Screen width/height:1600/1200 17:05:53 INFO - PROCESS | 6971 | colorDepth:24 17:05:53 INFO - PROCESS | 6971 | Browser inner width/height: 1024/697 17:05:53 INFO - PROCESS | 6971 | __metrics 17:05:53 INFO - PROCESS | 6971 | 1486256753964 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmpXe_doi/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpXe_doi/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpXe_doi/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpXe_doi/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:05:54 ERROR - PROCESS | 6971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:05:55 INFO - TEST-INFO | 6971: exit 0 17:05:55 INFO - Browser initialized. 17:05:55 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:55 INFO - TEST-INFO | started process 7090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXe_doi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:07 INFO - PROCESS | 7090 | RSS: Main: 158822400 17:06:07 INFO - PROCESS | 7090 | 17:09:11 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35707/tests/dromaeo/cssquery-ext.html) 17:09:13 INFO - PROCESS | 7090 | RSS: Main: 171257856 17:09:13 INFO - PROCESS | 7090 | 17:10:55 INFO - PROCESS | 7090 | ************************* 17:10:55 INFO - PROCESS | 7090 | A coding exception was thrown and uncaught in a Task. 17:10:55 INFO - PROCESS | 7090 | 17:10:55 ERROR - PROCESS | 7090 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:10:55 INFO - PROCESS | 7090 | Full stack: 17:10:55 INFO - PROCESS | 7090 | ************************* 17:12:15 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-ext.html (next: http://localhost:35707/tests/dromaeo/cssquery-jquery.html) 17:12:16 INFO - PROCESS | 7090 | RSS: Main: 163655680 17:12:16 INFO - PROCESS | 7090 | 17:15:18 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35707/tests/dromaeo/cssquery-mootools.html) 17:15:19 INFO - PROCESS | 7090 | RSS: Main: 170909696 17:15:19 INFO - PROCESS | 7090 | 17:18:21 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35707/tests/dromaeo/cssquery-prototype.html) 17:18:22 INFO - PROCESS | 7090 | RSS: Main: 163983360 17:18:22 INFO - PROCESS | 7090 | 17:21:25 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35707/tests/dromaeo/cssquery-yui.html) 17:21:25 INFO - PROCESS | 7090 | RSS: Main: 167698432 17:21:25 INFO - PROCESS | 7090 | 17:24:28 INFO - PROCESS | 7090 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-yui.html (next: http://localhost:35707/tests/dromaeo/cssquery-dojo.html) 17:24:29 INFO - PROCESS | 7090 | RSS: Main: 168951808 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | __start_tp_report 17:24:29 INFO - PROCESS | 7090 | _x_x_mozilla_page_load 17:24:29 INFO - PROCESS | 7090 | _x_x_mozilla_page_load_details 17:24:29 INFO - PROCESS | 7090 | |i|pagename|runs| 17:24:29 INFO - PROCESS | 7090 | |0;dojo.html;2582.7159012508628;2588.184721812629;2605.322616119811;2618.33232525706;2629.539830529656;4815.085133824576;4817.373741413611;4818.445878723948;4821.638377121717;4848.078865015649;4780.617550595944;4805.327254184408;4845.1036558236665;4845.152098382787;4910.41075070992;4229.0911385156;4428.9114217715705;4445.599896009358;4566.132434837386;4567.155076310876;4508.752018638974;4526.094781043788;4532.864014079566;4534.637229021687;4538.092381523692;4378.5183629800695;4409.11817636474;4425.513193548707;4427.845025424094;4451.132029254297;4401.361802538646;4418.690691651585;4440;4465.9106817863785;4473.418455600784;4349.717268377577;4373.693841431101;4381.4961279452955;4402.3176407656865;4451.243288640939;4687.601553867926;4703.764811759398;4717.834875779366;4754.096721622881;4830.227163653799;5148.304978827848;5150.330457040598;5198.896022079537;5215.556677682402;5231.450697676727;5207.401148867891;5222;5222.556082732972;5233.084210263189;5274.709890955995;4667.649926255544;4764;4828.275758636232;4858.684185527929;4860.9999999999645;5129.076766182048;5171.301874247004;5205.063088644005;5219.217117432339;5286.814961476407;4986.351774269394;5023.49765023502;5034.647574669738;5050.77271522775;5122.897542049138;5141.871453213699;5142.357205349332;5143.996920600522;5150.819721309736;5160.380754309432;4990.226514890198;5034.748262586856;5078.162103252996;5105.106606343875;5122.513361230677;5065.56942659878;5073.518015788494;5080.034793389244;5116.155834287301;5152.974235128875;4341.435613370241;4342.609165175086;4347.58697923703;4347.7826108694435;4383.3863259143745;3717.6096509866616;3761.6238376162714;3764.8682296119505;3806;3813.809309534512;4378.43080399546;4414.4702635683925;4417.933730994037;4441.511433742286;4485.102979404067;5159.045576568347;5175.844724658266;5198.558122559625;5199.922001169985;5222.608304377187;4422.469303683579;4427.75647339393;4430.313301438282;4447.755373454426;4471.731696098244;4514.187446259639;4559.430071241095;4629.745364005012;4654.464736555272;4663.160631086437;4848.224284114524;4875.463698993179;4888.388951381077;4904.6566740327835;4930.728809915489;5202.8959420812125;5208.687478751287;5218.452062533531;5222.451642577626;5225.399079105951;4749.192637251745;4750.263709125091;4827.468978412442;4856.004519073511;4898.387701537308;5083.669561478492;5111.693298402108;5117.078925793244;5155.149400348901;5156.355455568054;5001.174806156943;5003.44962054181;5116.948830511647;5162.561182299547;5174.818881339135;4843.806247750051;4873.439554451284;4888.242322440027;4888.95111048885;4889.584385327287;4832.806687732451;4849.636277279289;4877.195262781744;4906.411230652345;4919.262110683283;4867.659263851497;4962.776675049559;4969.378827646544;4976.303317535476;5007.29897814299;5018.949810501995;5030.245463180552;5045.142325804549;5049.368828896388;5057.671251368796;4789.712617242976;4833.275008748716;4878.829240976549;4951.331570238116;5002.949970500248 17:24:29 INFO - PROCESS | 7090 | |1;ext.html;535.1357557544566;537.6156048425376;543.4348277791097;551.330133887327;558.1961974756354;38258.61741382585;38823;38929.22141557167;38951.22097558047;41603;38845;39335.803320983425;39365.60634393655;39407.40888886669;39448;7612.619369031554;7726.690932362699;7769.145394006655;9083.910700538847;9285.675001374953;9278.0721927807;9326.766830829216;9330.673426430043;9365;9367.34428589999;9349.67276145335;9383.249340052813;9391.154796068353;9407.153356197941;9413.152816246537;9269.721908342726;9327.486988215645;9331.393459425184;9331.813363732756;9337;9262.351635385527;9351.708831336366;9358;9359.62561497546;9371.671991480334;32113.51829722556;32136.517952230733;32140.678593214;32196.356072878647;32217.51673724896;3307.536944827726;3345.3476572068457;3420.9486857697157;3459.4810778383194;3495.7028652564563;23683.763162368326;24624.630630540556;24852.751472485405;24862.627060594106;25554.48891022169;3362.1258472797003;3416;3416.7266618670446;3447.413939630244;3456.3260164267977;218660;219131;219262;219279.80720192753;220041;40069.59930400659;40995.79502102471;45624.77187614041;45771.31343029857;45925;45164.54835451669;48744;48915.26627100597;49187;49298.75350623224;11735.061195104372;11772.234804737836;11855.940720296343;11863.940680296544;11882;9042.819143617222;9104.635814567475;9105.089491050841;9113.362064655543;9123.908760912438;15529.456469023757;15605.82956278261;15676.216189190494;15681.294341754648;15777.447789327318;6703.22912865017;6817.454603631698;6869.553479023847;6916.031755554226;6977.197622273402;781.9022622172229;792.7582087463263;808.0707186735301;811.7402431222071;819.6065888373614;26820.329491762473;27276.181714548595;27320;27460.45079098407;27726.722732772818;915.2357781252729;936.1293996583107;947.8388673925449;948.6015873333216;961.7307153996892;13606.31968401576;13714.17714937087;14600.196989165486;14636.268186590627;14691.926540367229;333940;338045;338230;340792;340894;49186.26220606694;49730.50269497259;49741.502584973685;49803.75098124559;49908.25137622938;1231.2120243044458;1242.136714983078;1265.3167289663663;1266.9809952850899;1267.5310135250018;25097.372565685273;26016.01631624699;27078.418042948007;27112.864435678486;27384.58923116115;42131.57868421276;42921;42945.3558196621;42945.785271073444;43223.783881080395;240931;242617;243673;243897;244208;30825.38349232958;31610;34535.48196777;35729.1067723309;36299.63700362963;37762.811185943894;37971.81014094912;38164.618353816106;39448;40563.797181015085;31441.21396965094;31468.685313147493;31661.525077123402;31681;32885;31606.841965790023;31938.840305798323;32041.35917281688;32876;33226.18220358083;31754.206144846565;32144.19639509031;32222.19444513906;32352.514712278862;32606;27035.45929081368;27964.720352796212;29317.560236596895;29372.265693357836;29378.853105734335;22326.33021009372;22551;22755.31734047981;22821.771782281965;22853.771462285164 17:24:29 INFO - PROCESS | 7090 | |2;jquery.html;377.84319507404444;386.7281916062406;394.34538665814745;394.84995701633386;414.86931616540807;12762.936185319084;13039.93480032601;15973.680526389466;17644.73532897006;17655.29378824847;13442.462301507929;17719.645607087852;17823.197956091975;17889.642207155848;18197.18112684929;5089.465606111351;5335.359756829186;5354.651947623392;5356.330458692663;5361.865953351158;5143.177091665334;5180.611454140954;5184.740762961856;5263.289455923439;5274.973625131869;5219.42586315505;5236.136037553799;5238.214267859832;5247;5256.369235691704;5068.341115654978;5185.922211166836;5223.033738758342;5224.686518808883;5228.294180285651;4744.667873248874;4764.7617619119255;4770.045990801854;4772.188727916263;4772.522747725235;17525.7371139433;22007.889960550096;22079.44801379962;22080.337589872328;22138.22516211941;2252.5044490212126;2373.8575685458754;2376.4415362389823;2379.214859096494;2413.794827439652;13600.523981660694;13653.931730341284;13835.30823458833;14037.649058773612;14439.278036098258;1726.6719323328527;1728.3086765293983;1753.2198171813548;1774.325756212631;1801.2794882047156;64117.67941160311;71254;71569.64215178943;72170;72284.63857680731;10236.283460157718;10451.94774026125;10457.267991240693;10545.894541054644;10664.41345725977;14777.113373197642;14844.92577537127;14856;14901.70196596062;14923.70152596942;6587.9670601646685;6831.658417079127;6879.245792322926;7010.824729381704;7065.4700897432895;6221.3156552779155;6269.529785266123;6368.267649220306;6396.61620302774;6455.4835613150835;6498.870022599522;6595.571287866273;6719.361660642231;6751.156105486814;6960.9303906961295;1752.7195648696147;1785.669651114548;1803.323753592403;1819.1359104425292;1850.9259629614935;935.5415846235296;945.7493764152505;948.9762755931157;964.864918911353;971.6550624528332;16817;17290.827091729174;17890.463286101436;18104.36634717805;18593.628127437376;925.8472352061834;928.7724507495707;939.262678797141;943.1228957069991;955.7085089047907;9536.523173841419;10182.439965801952;10261.230407719451;10263.7434064149;10360.430176340373;424201;478698;478792;500859;501124;75395;76132;76461;80169;80814;896.5651658945407;906.4289497616592;923.2567782934668;925.421611492817;960.3469640644429;15268.770968435705;16393.19682331819;16413.83586164123;16802.66394672124;16828.326866925676;40123.398149027205;40137.39793903152;40851.591484084776;40876.59123408728;40995.1800963985;53384.466155339505;54293.61219276974;54818;55976.720116399156;56235.437645624654;7942.880856787037;7980.8004799878145;7981.403719256288;8168.877466838121;8568.828623427371;11822.34977076269;11960.222585531912;12951.5466958656;12965.611031669065;12992.935035324763;10109.797804044025;10118.696439106838;10592.570003049797;10744.409057501913;11098.667039988813;10719.785604287714;10772.838407423738;10825.945870270598;11028;11239;10264.553434999876;10646.84029739539;10888.237823352289;10890.94554527254;11121.443927803739;6877.828054298682;7294.598797066213;7339.229380914927;7972.123066462568;8288.958555207186;10487;10989.780204395707;11010.3944283062;11392.658220253406;11413.201075924606 17:24:29 INFO - PROCESS | 7090 | |3;mootools.html;1337.9598612041636;1350.864913508649;1351.1690310459064;1354.2551596621859;1363.5227670315385;7235.167955685098;7487.43844211685;7605.505642133257;7650.885236721447;7651.464397492177;7723.304902558769;7836.804079897991;7843;7850.254225848549;7886.77754947984;2137.316058861165;2168.078566609193;2179.3135162423864;2180.9345719628436;2187.2016713899393;2095.5808838232338;2137.957240855182;2145.0990583954776;2158.5359147783224;2163.7836216378396;2110.905009274579;2121.9787802122014;2149.5271040371094;2154.493693981921;2157.590057888996;2106.3259756877806;2122.745270567542;2130.6697461893355;2130.7975742304457;2131.6163090643677;1838.3657638114828;1882.3223639489772;2007.5583371658213;2042.9795702042939;2157.8597391169524;7747.806304842367;7750.612469376565;7782.299593036654;7785.961070194669;7790.649420776079;4625.907481850344;4758.214894542396;4759.666823322369;4762.618990480788;4763.571278584909;2923.269182704324;2941.4999450093537;2958.2604348912773;2981.5825784390204;3006.4588374092873;1052.2108418685987;1078.1051727066515;1078.9298695584841;1092.7104317355906;1123.584273818684;10124.54439550222;10134.31440668216;10167.288289819715;10209.336393134348;10215.336003159771;3812.7140464465274;3998.520177578651;4033.4554835096887;4146.937795933063;4147.854825081107;8108.986376702912;8128.634211460499;8135;8143.633536490754;8163.020437547413;4493.146302202571;4497.977510112429;4516.977415112903;4596.816127354935;4615.053913947632;4178.456800615901;4224.809883555247;4228.175505776406;4304.569543045671;4316.503602085801;3258.7393008559256;3300.3234336960863;3379.4086034943784;3414.197663549064;3422.058933793227;1014.5802261606123;1035.761774791802;1037.071820720451;1037.123630532199;1043.9217058720626;747.4767662636176;770.7302444144617;778.4900889917113;780.968761249555;783.3615603283306;4840.903181936412;4856;4911.484294149063;5025.924611130836;5091.159958606862;545.5281181777734;547.5373309553421;548.4542879834511;550.6530885542082;553.8643032457073;3111.8755249789756;3122.9531557026207;3134.717875391226;3142.277276226435;3242.2542815152647;8243.670253189804;8618.267447267053;8771.64039573867;8876.245519130816;9017.864732029026;9259.212966897754;9304;9312.301577381724;9314.953425232967;9325.067493250757;6645.401913827779;6822.215445223764;6844.623545705034;7028.6485675714985;7033.120859892513;5098.1842905135;5233.6074794389815;5332.520073193431;5408.513233808976;5453.236546883519;8440.746777596436;8462.576871156542;8508.319334453352;8604.78488037779;8625.353098517762;8129.268365847102;8485.321174305916;8495.915040849759;8672.349573781865;8685.6091475885;6632.1709786276715;6722.428593569602;6743.9325606743305;6773.18721753373;6774.491913106438;7250.9637451812405;7292.525985810906;7323.231060738546;7327.560346379234;7346.33882950537;6627.4698024158915;6737.966310168614;6744.055832183596;6749.0888730020815;6774.966125169342;6581.3418658133805;6600.9339906602245;6628.900566491603;6667.733290668319;6677.599344039373;5797.652140871562;5816.912746308724;5889.764409423575;5951.613145145551;5970.194023806731;4223.303154979394;4251;4302.978485107555;4343.239933011773;4411.713238639478;4344.869653910388;4346.978265108654;4353.73877567347;4418.160549495586;4558.179527685049 17:24:29 INFO - PROCESS | 7090 | |4;prototype.html;356.77879714576966;357.99105022374437;360.9910300709518;362.856671614712;367.2819637608476;4955.975220123899;4999.9250011249815;5012.396033269355;5020.9497905020935;5022.899542009158;4936.580390666798;4980.427250866152;4983.601311895049;5000.7249601271915;5007.599392048636;3929.174873276608;3964.801759912007;3991.521017477892;4023.155137421145;4026.11425486394;3902.2585708715396;3965.3655415133585;3998.1603863188766;4003.11931375097;4043.2722110020186;3930;3953.308171070066;3958.34687276599;3999.2601368746728;4018.156187200677;3808.8857334280015;3943.38877473992;3986.740861843971;3999.340108882031;3999.6000399959917;3569.250457403948;3592.191756854713;3598.874039408608;3603.171510364378;3610.1696609779897;4888.266759985995;4902.583280421169;4905.141600219948;4913.189323761575;4920.5571498565305;4596.563326483979;4601.194790911577;4616.515265897099;4657.184992626277;4658.440987081538;4929.704217746947;5200.179937022012;5207.869803254911;5211.400688920785;5212.244224587452;3748.3440397930526;3753.981230093832;3755.8122093895195;3777.6788972937334;3780.073881898925;5219.947800522022;5511;5512.531434828044;5540.695261760601;5554.555635549146;3466.890595009623;3744.4008958566496;3760.360738674432;3764.0778009387877;3766.5103536540073;3834.8082595870096;3860.4209368594934;3867.6712479439;3871.690264778811;3874.2057878134915;4417.690761646718;4438.7114837535455;4440.289553671461;4442.355858400514;4467.285234362486;5098.745062746848;5221.903400285906;5230.607704422184;5274;5333.466653334713;1288.5168061976758;1295.740851829638;1299.4477347127433;1303.2766814417898;1311.698309388846;863.6631713631689;889.4485419040108;896.6189369517929;906.4289497616592;913.8720579118929;4393.538678438782;4394.450693663292;4397.2304846651705;4418.160549495586;4447.799849006802;5186.92219616706;5256.789728410898;5270.868228294324;5272.077386457355;5273.630845840754;4210.368444733314;4339.327404252346;4365.541618130051;4366.825326986948;4422.8721675973065;2732.9775965785175;2737.3293543082073;2741.575055866344;2743.6981931987866;2753.1553858914576;4830.975845120752;4846.546036189129;4862.027594481118;4866.562009419169;4896.926546101811;5113.411957624847;5306.363236411578;5309.8938021239355;5313.654612450178;5343.332083489564;4776.140294746979;4833.4441539222735;4838.540338667821;4847.418309802846;4858.975705121452;5193.792248310026;5195.765820697136;5201.505856943584;5216.713080780593;5237.502437268454;4987.650864439454;5001.899962000813;5043.394792624908;5168.147255702767;5176.498815343659;4813.7593120344545;4872.366592342973;4897;4905.541593176873;5017.297578338962;3806.8096595169577;3840.7887566184127;3858.9035274118373;3861.436118372064;3869.671077958405;5368.792021795065;5378.784848606012;5385;5394.2448057272795;5417.756200971045;4816.20532612115;5017.774200160929;5137.845864624067;5148.794048238178;5170.612204084633;5060.291559181644;5075.771590278372;5081.002208696887;5114.974425127999;5126.538611524831;5085.542301192911;5106.821261255838;5110.284560161655;5130.384353877409;5133.4096578893905;4987.279388610923;5205.8177963772605;5220.295260139985;5221.877296381296;5226.425093239816;5084.491550844886;5095.490450955023;5096.904165604413;5120.155174396183;5134.71632091977 17:24:29 INFO - PROCESS | 7090 | |5;yui.html;636.1443858010973;652.2433976587157;722.036081830756;738.2248638929123;750.5946788734084;11545.711357216074;12490.937545312261;12542.059345549085;12574.685632859184;12587.937060314709;12128.332941688204;12263.386830658475;12270.938645306762;12274.20217685852;12309.446074926627;764.7782143178486;768.1051574915217;794.7019867549669;797.099277816067;802.4142376065475;785.3834739729314;786.9960650196741;788.2275370137269;788.846174995876;791.2008871040262;812.1350761439078;813.093400858042;813.9511629302232;816.0819078536646;820.0651257566379;809.8420807942483;812.475953010305;814.5927036481759;814.9103598604149;816.7141500474816;589.858433975847;593.9465448109647;594.4679511836882;594.7412875399172;595.1073389915127;12878.29169395683;12913.418896149697;13155.342232888317;13164.6708832279;13200.273984930825;11332.773344533145;12026.15816892818;12219.389030548436;12379.75240495194;12478;10051.655306476534;10066.547005384775;10183.490825458697;10210.387376757344;10256;3106.9067927962196;3122.6408962969094;3141.3301662707795;3154.4164329598866;3176.237702951275;60375.09437358487;60537.6973115136;61638.38361616416;62178.68910655463;62860;9288.442693438416;9366.859497107549;9544.904550954401;9629.32594718377;9654.903450965401;17091.316347346215;17926.462206133838;17975.640487190445;18747;18959;6351.714172862232;6353.269374022047;6421.101045853584;6425.839354016093;6482.805515834532;3533.116720819795;3556.110972256936;3578.874739384109;3593.640635936438;3637.672609465161;3034.1656044587917;3117.173948903542;3117.7817552771544;3126.124685088179;3143.701348371901;548.9396166421691;553.7425097329761;557.8382269141904;561.2479277767811;574.2678085441096;584.7164125399178;609.689168288184;624.1760875644197;625.3152797686525;627.9403456671608;8047.114817370085;8136.674533018613;8191.8771218431775;8339.24946754795;8341.518100737116;599.5802937943457;611.1047315682457;632.0834789555163;637.5664548107331;645.1033064040987;4216.746995180299;4389.779021978692;4403.9779801100785;4671.832041989503;4741.880647758823;66056;66664.33335666679;67686.66156669185;67860.6606966962;69358;50046;56632.433675662716;57732.422675773545;59393;61658.69170654118;50505;50956.49043509518;51575.484245157066;51931;52038.73980630073;7590.658420370986;7761.9611901940125;7773.300402963534;7781.688732450639;7986.92013079885;35417;35451.645483545864;36482.63517364793;37017.444738328406;37298.627013729514;43202;44095.77952110219;46223.3066503996;47139.76430117827;47773;10831.512581933674;10845.403502807421;11012.944935275273;11019.118470522179;11195.60815371458;12476.18904771187;12536.498540058661;12572.559960401342;12765.297908614744;12934.870651293366;10103.54534045955;10234.437105958947;10307.742306442398;10334.741631459274;10688.893111069101;10998.175136864607;11438.714032149262;11869.703257418634;12009.459574319002;12370;11281.266717663326;11500.712482188012;11619.88380116222;11663.183577149519;12145.878541214828;8519.275861551838;8990.955045224993;9009.774755631162;9278.164965153168;9732.221422286058;8854.776892983971;9001.459912405015;9826.361286516354;9903.29165983689;9939.155171810187 17:24:29 INFO - PROCESS | 7090 | __end_tp_report 17:24:29 INFO - PROCESS | 7090 | __start_cc_report 17:24:29 INFO - PROCESS | 7090 | _x_x_mozilla_cycle_collect,398 17:24:29 INFO - PROCESS | 7090 | __end_cc_report 17:24:29 INFO - PROCESS | 7090 | __startTimestamp1486257869155__endTimestamp 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | ------- Summary: start ------- 17:24:29 INFO - PROCESS | 7090 | Number of tests: 6 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#0] dojo.html Cycles:165 Average:4744.64 Median:4858.68 stddev:507.80 (10.5%) stddev-sans-first:480.20 17:24:29 INFO - PROCESS | 7090 | Values: 2582.7 2588.2 2605.3 2618.3 2629.5 4815.1 4817.4 4818.4 4821.6 4848.1 4780.6 4805.3 4845.1 4845.2 4910.4 4229.1 4428.9 4445.6 4566.1 4567.2 4508.8 4526.1 4532.9 4534.6 4538.1 4378.5 4409.1 4425.5 4427.8 4451.1 4401.4 4418.7 4440.0 4465.9 4473.4 4349.7 4373.7 4381.5 4402.3 4451.2 4687.6 4703.8 4717.8 4754.1 4830.2 5148.3 5150.3 5198.9 5215.6 5231.5 5207.4 5222.0 5222.6 5233.1 5274.7 4667.6 4764.0 4828.3 4858.7 4861.0 5129.1 5171.3 5205.1 5219.2 5286.8 4986.4 5023.5 5034.6 5050.8 5122.9 5141.9 5142.4 5144.0 5150.8 5160.4 4990.2 5034.7 5078.2 5105.1 5122.5 5065.6 5073.5 5080.0 5116.2 5153.0 4341.4 4342.6 4347.6 4347.8 4383.4 3717.6 3761.6 3764.9 3806.0 3813.8 4378.4 4414.5 4417.9 4441.5 4485.1 5159.0 5175.8 5198.6 5199.9 5222.6 4422.5 4427.8 4430.3 4447.8 4471.7 4514.2 4559.4 4629.7 4654.5 4663.2 4848.2 4875.5 4888.4 4904.7 4930.7 5202.9 5208.7 5218.5 5222.5 5225.4 4749.2 4750.3 4827.5 4856.0 4898.4 5083.7 5111.7 5117.1 5155.1 5156.4 5001.2 5003.4 5116.9 5162.6 5174.8 4843.8 4873.4 4888.2 4889.0 4889.6 4832.8 4849.6 4877.2 4906.4 4919.3 4867.7 4962.8 4969.4 4976.3 5007.3 5018.9 5030.2 5045.1 5049.4 5057.7 4789.7 4833.3 4878.8 4951.3 5002.9 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#1] ext.html Cycles:180 Average:41901.74 Median:3457.90 stddev:71192.13 (2058.8%) stddev-sans-first:71324.09 17:24:29 INFO - PROCESS | 7090 | Values: 535.1 537.6 543.4 551.3 558.2 38258.6 38823.0 38929.2 38951.2 41603.0 38845.0 39335.8 39365.6 39407.4 39448.0 7612.6 7726.7 7769.1 9083.9 9285.7 9278.1 9326.8 9330.7 9365.0 9367.3 9349.7 9383.2 9391.2 9407.2 9413.2 9269.7 9327.5 9331.4 9331.8 9337.0 9262.4 9351.7 9358.0 9359.6 9371.7 32113.5 32136.5 32140.7 32196.4 32217.5 3307.5 3345.3 3420.9 3459.5 3495.7 23683.8 24624.6 24852.8 24862.6 25554.5 3362.1 3416.0 3416.7 3447.4 3456.3 218660.0 219131.0 219262.0 219279.8 220041.0 40069.6 40995.8 45624.8 45771.3 45925.0 45164.5 48744.0 48915.3 49187.0 49298.8 11735.1 11772.2 11855.9 11863.9 11882.0 9042.8 9104.6 9105.1 9113.4 9123.9 15529.5 15605.8 15676.2 15681.3 15777.4 6703.2 6817.5 6869.6 6916.0 6977.2 781.9 792.8 808.1 811.7 819.6 26820.3 27276.2 27320.0 27460.5 27726.7 915.2 936.1 947.8 948.6 961.7 13606.3 13714.2 14600.2 14636.3 14691.9 333940.0 338045.0 338230.0 340792.0 340894.0 49186.3 49730.5 49741.5 49803.8 49908.3 1231.2 1242.1 1265.3 1267.0 1267.5 25097.4 26016.0 27078.4 27112.9 27384.6 42131.6 42921.0 42945.4 42945.8 43223.8 240931.0 242617.0 243673.0 243897.0 244208.0 30825.4 31610.0 34535.5 35729.1 36299.6 37762.8 37971.8 38164.6 39448.0 40563.8 31441.2 31468.7 31661.5 31681.0 32885.0 31606.8 31938.8 32041.4 32876.0 33226.2 31754.2 32144.2 32222.2 32352.5 32606.0 27035.5 27964.7 29317.6 29372.3 29378.9 22326.3 22551.0 22755.3 22821.8 22853.8 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#2] jquery.html Cycles:180 Average:27323.06 Median:40864.09 stddev:78407.23 (191.9%) stddev-sans-first:78601.07 17:24:29 INFO - PROCESS | 7090 | Values: 377.8 386.7 394.3 394.8 414.9 12762.9 13039.9 15973.7 17644.7 17655.3 13442.5 17719.6 17823.2 17889.6 18197.2 5089.5 5335.4 5354.7 5356.3 5361.9 5143.2 5180.6 5184.7 5263.3 5275.0 5219.4 5236.1 5238.2 5247.0 5256.4 5068.3 5185.9 5223.0 5224.7 5228.3 4744.7 4764.8 4770.0 4772.2 4772.5 17525.7 22007.9 22079.4 22080.3 22138.2 2252.5 2373.9 2376.4 2379.2 2413.8 13600.5 13653.9 13835.3 14037.6 14439.3 1726.7 1728.3 1753.2 1774.3 1801.3 64117.7 71254.0 71569.6 72170.0 72284.6 10236.3 10451.9 10457.3 10545.9 10664.4 14777.1 14844.9 14856.0 14901.7 14923.7 6588.0 6831.7 6879.2 7010.8 7065.5 6221.3 6269.5 6368.3 6396.6 6455.5 6498.9 6595.6 6719.4 6751.2 6960.9 1752.7 1785.7 1803.3 1819.1 1850.9 935.5 945.7 949.0 964.9 971.7 16817.0 17290.8 17890.5 18104.4 18593.6 925.8 928.8 939.3 943.1 955.7 9536.5 10182.4 10261.2 10263.7 10360.4 424201.0 478698.0 478792.0 500859.0 501124.0 75395.0 76132.0 76461.0 80169.0 80814.0 896.6 906.4 923.3 925.4 960.3 15268.8 16393.2 16413.8 16802.7 16828.3 40123.4 40137.4 40851.6 40876.6 40995.2 53384.5 54293.6 54818.0 55976.7 56235.4 7942.9 7980.8 7981.4 8168.9 8568.8 11822.3 11960.2 12951.5 12965.6 12992.9 10109.8 10118.7 10592.6 10744.4 11098.7 10719.8 10772.8 10825.9 11028.0 11239.0 10264.6 10646.8 10888.2 10890.9 11121.4 6877.8 7294.6 7339.2 7972.1 8289.0 10487.0 10989.8 11010.4 11392.7 11413.2 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#3] mootools.html Cycles:180 Average:4943.19 Median:4848.45 stddev:2749.84 (56.7%) stddev-sans-first:2744.21 17:24:29 INFO - PROCESS | 7090 | Values: 1338.0 1350.9 1351.2 1354.3 1363.5 7235.2 7487.4 7605.5 7650.9 7651.5 7723.3 7836.8 7843.0 7850.3 7886.8 2137.3 2168.1 2179.3 2180.9 2187.2 2095.6 2138.0 2145.1 2158.5 2163.8 2110.9 2122.0 2149.5 2154.5 2157.6 2106.3 2122.7 2130.7 2130.8 2131.6 1838.4 1882.3 2007.6 2043.0 2157.9 7747.8 7750.6 7782.3 7786.0 7790.6 4625.9 4758.2 4759.7 4762.6 4763.6 2923.3 2941.5 2958.3 2981.6 3006.5 1052.2 1078.1 1078.9 1092.7 1123.6 10124.5 10134.3 10167.3 10209.3 10215.3 3812.7 3998.5 4033.5 4146.9 4147.9 8109.0 8128.6 8135.0 8143.6 8163.0 4493.1 4498.0 4517.0 4596.8 4615.1 4178.5 4224.8 4228.2 4304.6 4316.5 3258.7 3300.3 3379.4 3414.2 3422.1 1014.6 1035.8 1037.1 1037.1 1043.9 747.5 770.7 778.5 781.0 783.4 4840.9 4856.0 4911.5 5025.9 5091.2 545.5 547.5 548.5 550.7 553.9 3111.9 3123.0 3134.7 3142.3 3242.3 8243.7 8618.3 8771.6 8876.2 9017.9 9259.2 9304.0 9312.3 9315.0 9325.1 6645.4 6822.2 6844.6 7028.6 7033.1 5098.2 5233.6 5332.5 5408.5 5453.2 8440.7 8462.6 8508.3 8604.8 8625.4 8129.3 8485.3 8495.9 8672.3 8685.6 6632.2 6722.4 6743.9 6773.2 6774.5 7251.0 7292.5 7323.2 7327.6 7346.3 6627.5 6738.0 6744.1 6749.1 6775.0 6581.3 6600.9 6628.9 6667.7 6677.6 5797.7 5816.9 5889.8 5951.6 5970.2 4223.3 4251.0 4303.0 4343.2 4411.7 4344.9 4347.0 4353.7 4418.2 4558.2 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#4] prototype.html Cycles:180 Average:4301.42 Median:4869.46 stddev:1225.46 (25.2%) stddev-sans-first:1192.60 17:24:29 INFO - PROCESS | 7090 | Values: 356.8 358.0 361.0 362.9 367.3 4956.0 4999.9 5012.4 5020.9 5022.9 4936.6 4980.4 4983.6 5000.7 5007.6 3929.2 3964.8 3991.5 4023.2 4026.1 3902.3 3965.4 3998.2 4003.1 4043.3 3930.0 3953.3 3958.3 3999.3 4018.2 3808.9 3943.4 3986.7 3999.3 3999.6 3569.3 3592.2 3598.9 3603.2 3610.2 4888.3 4902.6 4905.1 4913.2 4920.6 4596.6 4601.2 4616.5 4657.2 4658.4 4929.7 5200.2 5207.9 5211.4 5212.2 3748.3 3754.0 3755.8 3777.7 3780.1 5219.9 5511.0 5512.5 5540.7 5554.6 3466.9 3744.4 3760.4 3764.1 3766.5 3834.8 3860.4 3867.7 3871.7 3874.2 4417.7 4438.7 4440.3 4442.4 4467.3 5098.7 5221.9 5230.6 5274.0 5333.5 1288.5 1295.7 1299.4 1303.3 1311.7 863.7 889.4 896.6 906.4 913.9 4393.5 4394.5 4397.2 4418.2 4447.8 5186.9 5256.8 5270.9 5272.1 5273.6 4210.4 4339.3 4365.5 4366.8 4422.9 2733.0 2737.3 2741.6 2743.7 2753.2 4831.0 4846.5 4862.0 4866.6 4896.9 5113.4 5306.4 5309.9 5313.7 5343.3 4776.1 4833.4 4838.5 4847.4 4859.0 5193.8 5195.8 5201.5 5216.7 5237.5 4987.7 5001.9 5043.4 5168.1 5176.5 4813.8 4872.4 4897.0 4905.5 5017.3 3806.8 3840.8 3858.9 3861.4 3869.7 5368.8 5378.8 5385.0 5394.2 5417.8 4816.2 5017.8 5137.8 5148.8 5170.6 5060.3 5075.8 5081.0 5115.0 5126.5 5085.5 5106.8 5110.3 5130.4 5133.4 4987.3 5205.8 5220.3 5221.9 5226.4 5084.5 5095.5 5096.9 5120.2 5134.7 17:24:29 INFO - PROCESS | 7090 | 17:24:29 INFO - PROCESS | 7090 | [#5] yui.html Cycles:180 Average:14612.82 Median:26293.84 stddev:18453.29 (70.2%) stddev-sans-first:18475.21 17:24:29 INFO - PROCESS | 7090 | Values: 636.1 652.2 722.0 738.2 750.6 11545.7 12490.9 12542.1 12574.7 12587.9 12128.3 12263.4 12270.9 12274.2 12309.4 764.8 768.1 794.7 797.1 802.4 785.4 787.0 788.2 788.8 791.2 812.1 813.1 814.0 816.1 820.1 809.8 812.5 814.6 814.9 816.7 589.9 593.9 594.5 594.7 595.1 12878.3 12913.4 13155.3 13164.7 13200.3 11332.8 12026.2 12219.4 12379.8 12478.0 10051.7 10066.5 10183.5 10210.4 10256.0 3106.9 3122.6 3141.3 3154.4 3176.2 60375.1 60537.7 61638.4 62178.7 62860.0 9288.4 9366.9 9544.9 9629.3 9654.9 17091.3 17926.5 17975.6 18747.0 18959.0 6351.7 6353.3 6421.1 6425.8 6482.8 3533.1 3556.1 3578.9 3593.6 3637.7 3034.2 3117.2 3117.8 3126.1 3143.7 548.9 553.7 557.8 561.2 574.3 584.7 609.7 624.2 625.3 627.9 8047.1 8136.7 8191.9 8339.2 8341.5 599.6 611.1 632.1 637.6 645.1 4216.7 4389.8 4404.0 4671.8 4741.9 66056.0 66664.3 67686.7 67860.7 69358.0 50046.0 56632.4 57732.4 59393.0 61658.7 50505.0 50956.5 51575.5 51931.0 52038.7 7590.7 7762.0 7773.3 7781.7 7986.9 35417.0 35451.6 36482.6 37017.4 37298.6 43202.0 44095.8 46223.3 47139.8 47773.0 10831.5 10845.4 11012.9 11019.1 11195.6 12476.2 12536.5 12572.6 12765.3 12934.9 10103.5 10234.4 10307.7 10334.7 10688.9 10998.2 11438.7 11869.7 12009.5 12370.0 11281.3 11500.7 11619.9 11663.2 12145.9 8519.3 8991.0 9009.8 9278.2 9732.2 8854.8 9001.5 9826.4 9903.3 9939.2 17:24:29 INFO - PROCESS | 7090 | -------- Summary: end -------- 17:24:29 INFO - PROCESS | 7090 | 17:24:30 INFO - TEST-INFO | 7090: exit 0 17:24:30 INFO - TEST-OK | dromaeo_css | took 1121855ms 17:24:30 INFO - TEST-START | kraken 17:24:30 INFO - operating with platform_type : linux_ 17:24:30 INFO - Initialising browser for kraken test... 17:24:30 INFO - TEST-INFO | started process 7438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_ztbP/profile http://localhost:35707/getInfo.html) 17:24:34 INFO - PROCESS | 7438 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:24:34 INFO - PROCESS | 7438 | __metrics Screen width/height:1600/1200 17:24:34 INFO - PROCESS | 7438 | colorDepth:24 17:24:34 INFO - PROCESS | 7438 | Browser inner width/height: 1024/697 17:24:34 INFO - PROCESS | 7438 | __metrics 17:24:35 INFO - PROCESS | 7438 | 1486257875480 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmpj_ztbP/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpj_ztbP/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpj_ztbP/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpj_ztbP/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:24:35 ERROR - PROCESS | 7438 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:24:36 INFO - TEST-INFO | 7438: exit 0 17:24:36 INFO - Browser initialized. 17:24:36 INFO - Running cycle 1/1 for kraken test... 17:24:36 INFO - TEST-INFO | started process 7557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj_ztbP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:48 INFO - PROCESS | 7557 | RSS: Main: 160968704 17:24:48 INFO - PROCESS | 7557 | 17:24:51 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:52 INFO - PROCESS | 7557 | RSS: Main: 166133760 17:24:52 INFO - PROCESS | 7557 | 17:24:55 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-dft) 17:24:56 INFO - PROCESS | 7557 | RSS: Main: 165572608 17:24:56 INFO - PROCESS | 7557 | 17:24:59 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-fft) 17:24:59 INFO - PROCESS | 7557 | RSS: Main: 161550336 17:24:59 INFO - PROCESS | 7557 | 17:25:01 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-oscillator) 17:25:02 INFO - PROCESS | 7557 | RSS: Main: 161845248 17:25:02 INFO - PROCESS | 7557 | 17:25:04 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:25:05 INFO - PROCESS | 7557 | RSS: Main: 161972224 17:25:05 INFO - PROCESS | 7557 | 17:25:08 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-darkroom) 17:25:09 INFO - PROCESS | 7557 | RSS: Main: 166887424 17:25:09 INFO - PROCESS | 7557 | 17:25:12 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-desaturate) 17:25:13 INFO - PROCESS | 7557 | RSS: Main: 163508224 17:25:13 INFO - PROCESS | 7557 | 17:25:16 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35707/tests/kraken/driver.html?testName=json-parse-financial) 17:25:16 INFO - PROCESS | 7557 | RSS: Main: 164147200 17:25:16 INFO - PROCESS | 7557 | 17:25:18 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:25:19 INFO - PROCESS | 7557 | RSS: Main: 164597760 17:25:19 INFO - PROCESS | 7557 | 17:25:21 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:25:21 INFO - PROCESS | 7557 | RSS: Main: 164524032 17:25:21 INFO - PROCESS | 7557 | 17:25:24 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:25:24 INFO - PROCESS | 7557 | RSS: Main: 164945920 17:25:24 INFO - PROCESS | 7557 | 17:25:27 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:25:28 INFO - PROCESS | 7557 | RSS: Main: 165359616 17:25:28 INFO - PROCESS | 7557 | 17:25:31 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:25:32 INFO - PROCESS | 7557 | RSS: Main: 168357888 17:25:32 INFO - PROCESS | 7557 | 17:25:33 INFO - PROCESS | 7557 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35707/tests/kraken/driver.html?testName=ai-astar) 17:25:34 INFO - PROCESS | 7557 | RSS: Main: 169463808 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | __start_tp_report 17:25:34 INFO - PROCESS | 7557 | _x_x_mozilla_page_load 17:25:34 INFO - PROCESS | 7557 | _x_x_mozilla_page_load_details 17:25:34 INFO - PROCESS | 7557 | |i|pagename|runs| 17:25:34 INFO - PROCESS | 7557 | |0;ai-astar;107;115;115;114;115;117;117;114;115;116 17:25:34 INFO - PROCESS | 7557 | |1;audio-beat-detection;157;127;126;171;127;126;126;133;157;127 17:25:34 INFO - PROCESS | 7557 | |2;audio-dft;164;166;167;167;170;162;162;170;163;162 17:25:34 INFO - PROCESS | 7557 | |3;audio-fft;77;77;78;109;77;78;76;77;96;75 17:25:34 INFO - PROCESS | 7557 | |4;audio-oscillator;84;84;107;84;85;85;99;84;87;110 17:25:34 INFO - PROCESS | 7557 | |5;imaging-gaussian-blur;118;118;119;118;118;118;118;118;118;118 17:25:34 INFO - PROCESS | 7557 | |6;imaging-darkroom;151;149;151;150;150;151;150;151;149;152 17:25:34 INFO - PROCESS | 7557 | |7;imaging-desaturate;96;95;95;96;96;96;96;96;95;95 17:25:34 INFO - PROCESS | 7557 | |8;json-parse-financial;68;66;66;68;68;68;69;70;68;69 17:25:34 INFO - PROCESS | 7557 | |9;json-stringify-tinderbox;66;67;65;65;66;65;65;64;65;65 17:25:34 INFO - PROCESS | 7557 | |10;stanford-crypto-aes;87;85;92;84;85;89;84;87;91;88 17:25:34 INFO - PROCESS | 7557 | |11;stanford-crypto-ccm;142;151;129;151;141;139;134;134;216;148 17:25:34 INFO - PROCESS | 7557 | |12;stanford-crypto-pbkdf2;174;175;183;175;181;172;178;175;186;182 17:25:34 INFO - PROCESS | 7557 | |13;stanford-crypto-sha256-iterative;69;69;72;67;67;70;67;66;67;66 17:25:34 INFO - PROCESS | 7557 | __end_tp_report 17:25:34 INFO - PROCESS | 7557 | __start_cc_report 17:25:34 INFO - PROCESS | 7557 | _x_x_mozilla_cycle_collect,894 17:25:34 INFO - PROCESS | 7557 | __end_cc_report 17:25:34 INFO - PROCESS | 7557 | __startTimestamp1486257934079__endTimestamp 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | ------- Summary: start ------- 17:25:34 INFO - PROCESS | 7557 | Number of tests: 14 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.84 (2.5%) stddev-sans-first:1.12 17:25:34 INFO - PROCESS | 7557 | Values: 107.0 115.0 115.0 114.0 115.0 117.0 117.0 114.0 115.0 116.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:130.00 stddev:17.09 (13.1%) stddev-sans-first:16.64 17:25:34 INFO - PROCESS | 7557 | Values: 157.0 127.0 126.0 171.0 127.0 126.0 126.0 133.0 157.0 127.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.50 stddev:3.16 (1.9%) stddev-sans-first:3.32 17:25:34 INFO - PROCESS | 7557 | Values: 164.0 166.0 167.0 167.0 170.0 162.0 162.0 170.0 163.0 162.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:11.26 (14.6%) stddev-sans-first:11.80 17:25:34 INFO - PROCESS | 7557 | Values: 77.0 77.0 78.0 109.0 77.0 78.0 76.0 77.0 96.0 75.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.50 stddev:10.35 (12.3%) stddev-sans-first:10.68 17:25:34 INFO - PROCESS | 7557 | Values: 84.0 84.0 107.0 84.0 85.0 85.0 99.0 84.0 87.0 110.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:25:34 INFO - PROCESS | 7557 | Values: 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:25:34 INFO - PROCESS | 7557 | Values: 151.0 149.0 151.0 150.0 150.0 151.0 150.0 151.0 149.0 152.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:25:34 INFO - PROCESS | 7557 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 17:25:34 INFO - PROCESS | 7557 | Values: 68.0 66.0 66.0 68.0 68.0 68.0 69.0 70.0 68.0 69.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 17:25:34 INFO - PROCESS | 7557 | Values: 66.0 67.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 65.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:2.82 (3.2%) stddev-sans-first:2.99 17:25:34 INFO - PROCESS | 7557 | Values: 87.0 85.0 92.0 84.0 85.0 89.0 84.0 87.0 91.0 88.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:145.00 stddev:24.85 (17.1%) stddev-sans-first:26.25 17:25:34 INFO - PROCESS | 7557 | Values: 142.0 151.0 129.0 151.0 141.0 139.0 134.0 134.0 216.0 148.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:179.50 stddev:4.63 (2.6%) stddev-sans-first:4.67 17:25:34 INFO - PROCESS | 7557 | Values: 174.0 175.0 183.0 175.0 181.0 172.0 178.0 175.0 186.0 182.0 17:25:34 INFO - PROCESS | 7557 | 17:25:34 INFO - PROCESS | 7557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.94 (2.9%) stddev-sans-first:2.03 17:25:34 INFO - PROCESS | 7557 | Values: 69.0 69.0 72.0 67.0 67.0 70.0 67.0 66.0 67.0 66.0 17:25:34 INFO - PROCESS | 7557 | -------- Summary: end -------- 17:25:34 INFO - PROCESS | 7557 | 17:25:35 INFO - TEST-INFO | 7557: exit 0 17:25:35 INFO - TEST-OK | kraken | took 65157ms 17:25:35 INFO - SUITE-END | took 1187s 17:25:35 INFO - Completed test suite (00:19:47) 17:25:35 INFO - javascript benchmark 17:25:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6355.421713258235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.7159012508628, 2588.184721812629, 2605.322616119811, 2618.33232525706, 2629.539830529656, 4815.085133824576, 4817.373741413611, 4818.445878723948, 4821.638377121717, 4848.078865015649, 4780.617550595944, 4805.327254184408, 4845.1036558236665, 4845.152098382787, 4910.41075070992, 4229.0911385156, 4428.9114217715705, 4445.599896009358, 4566.132434837386, 4567.155076310876, 4508.752018638974, 4526.094781043788, 4532.864014079566, 4534.637229021687, 4538.092381523692, 4378.5183629800695, 4409.11817636474, 4425.513193548707, 4427.845025424094, 4451.132029254297, 4401.361802538646, 4418.690691651585, 4440.0, 4465.9106817863785, 4473.418455600784, 4349.717268377577, 4373.693841431101, 4381.4961279452955, 4402.3176407656865, 4451.243288640939, 4687.601553867926, 4703.764811759398, 4717.834875779366, 4754.096721622881, 4830.227163653799, 5148.304978827848, 5150.330457040598, 5198.896022079537, 5215.556677682402, 5231.450697676727, 5207.401148867891, 5222.0, 5222.556082732972, 5233.084210263189, 5274.709890955995, 4667.649926255544, 4764.0, 4828.275758636232, 4858.684185527929, 4860.9999999999645, 5129.076766182048, 5171.301874247004, 5205.063088644005, 5219.217117432339, 5286.814961476407, 4986.351774269394, 5023.49765023502, 5034.647574669738, 5050.77271522775, 5122.897542049138, 5141.871453213699, 5142.357205349332, 5143.996920600522, 5150.819721309736, 5160.380754309432, 4990.226514890198, 5034.748262586856, 5078.162103252996, 5105.106606343875, 5122.513361230677, 5065.56942659878, 5073.518015788494, 5080.034793389244, 5116.155834287301, 5152.974235128875, 4341.435613370241, 4342.609165175086, 4347.58697923703, 4347.7826108694435, 4383.3863259143745, 3717.6096509866616, 3761.6238376162714, 3764.8682296119505, 3806.0, 3813.809309534512, 4378.43080399546, 4414.4702635683925, 4417.933730994037, 4441.511433742286, 4485.102979404067, 5159.045576568347, 5175.844724658266, 5198.558122559625, 5199.922001169985, 5222.608304377187, 4422.469303683579, 4427.75647339393, 4430.313301438282, 4447.755373454426, 4471.731696098244, 4514.187446259639, 4559.430071241095, 4629.745364005012, 4654.464736555272, 4663.160631086437, 4848.224284114524, 4875.463698993179, 4888.388951381077, 4904.6566740327835, 4930.728809915489, 5202.8959420812125, 5208.687478751287, 5218.452062533531, 5222.451642577626, 5225.399079105951, 4749.192637251745, 4750.263709125091, 4827.468978412442, 4856.004519073511, 4898.387701537308, 5083.669561478492, 5111.693298402108, 5117.078925793244, 5155.149400348901, 5156.355455568054, 5001.174806156943, 5003.44962054181, 5116.948830511647, 5162.561182299547, 5174.818881339135, 4843.806247750051, 4873.439554451284, 4888.242322440027, 4888.95111048885, 4889.584385327287, 4832.806687732451, 4849.636277279289, 4877.195262781744, 4906.411230652345, 4919.262110683283, 4867.659263851497, 4962.776675049559, 4969.378827646544, 4976.303317535476, 5007.29897814299, 5018.949810501995, 5030.245463180552, 5045.142325804549, 5049.368828896388, 5057.671251368796, 4789.712617242976, 4833.275008748716, 4878.829240976549, 4951.331570238116, 5002.949970500248], "value": 4710.941312848092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.1357557544566, 537.6156048425376, 543.4348277791097, 551.330133887327, 558.1961974756354, 38258.61741382585, 38823.0, 38929.22141557167, 38951.22097558047, 41603.0, 38845.0, 39335.803320983425, 39365.60634393655, 39407.40888886669, 39448.0, 7612.619369031554, 7726.690932362699, 7769.145394006655, 9083.910700538847, 9285.675001374953, 9278.0721927807, 9326.766830829216, 9330.673426430043, 9365.0, 9367.34428589999, 9349.67276145335, 9383.249340052813, 9391.154796068353, 9407.153356197941, 9413.152816246537, 9269.721908342726, 9327.486988215645, 9331.393459425184, 9331.813363732756, 9337.0, 9262.351635385527, 9351.708831336366, 9358.0, 9359.62561497546, 9371.671991480334, 32113.51829722556, 32136.517952230733, 32140.678593214, 32196.356072878647, 32217.51673724896, 3307.536944827726, 3345.3476572068457, 3420.9486857697157, 3459.4810778383194, 3495.7028652564563, 23683.763162368326, 24624.630630540556, 24852.751472485405, 24862.627060594106, 25554.48891022169, 3362.1258472797003, 3416.0, 3416.7266618670446, 3447.413939630244, 3456.3260164267977, 218660.0, 219131.0, 219262.0, 219279.80720192753, 220041.0, 40069.59930400659, 40995.79502102471, 45624.77187614041, 45771.31343029857, 45925.0, 45164.54835451669, 48744.0, 48915.26627100597, 49187.0, 49298.75350623224, 11735.061195104372, 11772.234804737836, 11855.940720296343, 11863.940680296544, 11882.0, 9042.819143617222, 9104.635814567475, 9105.089491050841, 9113.362064655543, 9123.908760912438, 15529.456469023757, 15605.82956278261, 15676.216189190494, 15681.294341754648, 15777.447789327318, 6703.22912865017, 6817.454603631698, 6869.553479023847, 6916.031755554226, 6977.197622273402, 781.9022622172229, 792.7582087463263, 808.0707186735301, 811.7402431222071, 819.6065888373614, 26820.329491762473, 27276.181714548595, 27320.0, 27460.45079098407, 27726.722732772818, 915.2357781252729, 936.1293996583107, 947.8388673925449, 948.6015873333216, 961.7307153996892, 13606.31968401576, 13714.17714937087, 14600.196989165486, 14636.268186590627, 14691.926540367229, 333940.0, 338045.0, 338230.0, 340792.0, 340894.0, 49186.26220606694, 49730.50269497259, 49741.502584973685, 49803.75098124559, 49908.25137622938, 1231.2120243044458, 1242.136714983078, 1265.3167289663663, 1266.9809952850899, 1267.5310135250018, 25097.372565685273, 26016.01631624699, 27078.418042948007, 27112.864435678486, 27384.58923116115, 42131.57868421276, 42921.0, 42945.3558196621, 42945.785271073444, 43223.783881080395, 240931.0, 242617.0, 243673.0, 243897.0, 244208.0, 30825.38349232958, 31610.0, 34535.48196777, 35729.1067723309, 36299.63700362963, 37762.811185943894, 37971.81014094912, 38164.618353816106, 39448.0, 40563.797181015085, 31441.21396965094, 31468.685313147493, 31661.525077123402, 31681.0, 32885.0, 31606.841965790023, 31938.840305798323, 32041.35917281688, 32876.0, 33226.18220358083, 31754.206144846565, 32144.19639509031, 32222.19444513906, 32352.514712278862, 32606.0, 27035.45929081368, 27964.720352796212, 29317.560236596895, 29372.265693357836, 29378.853105734335, 22326.33021009372, 22551.0, 22755.31734047981, 22821.771782281965, 22853.771462285164], "value": 16795.253022909586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.84319507404444, 386.7281916062406, 394.34538665814745, 394.84995701633386, 414.86931616540807, 12762.936185319084, 13039.93480032601, 15973.680526389466, 17644.73532897006, 17655.29378824847, 13442.462301507929, 17719.645607087852, 17823.197956091975, 17889.642207155848, 18197.18112684929, 5089.465606111351, 5335.359756829186, 5354.651947623392, 5356.330458692663, 5361.865953351158, 5143.177091665334, 5180.611454140954, 5184.740762961856, 5263.289455923439, 5274.973625131869, 5219.42586315505, 5236.136037553799, 5238.214267859832, 5247.0, 5256.369235691704, 5068.341115654978, 5185.922211166836, 5223.033738758342, 5224.686518808883, 5228.294180285651, 4744.667873248874, 4764.7617619119255, 4770.045990801854, 4772.188727916263, 4772.522747725235, 17525.7371139433, 22007.889960550096, 22079.44801379962, 22080.337589872328, 22138.22516211941, 2252.5044490212126, 2373.8575685458754, 2376.4415362389823, 2379.214859096494, 2413.794827439652, 13600.523981660694, 13653.931730341284, 13835.30823458833, 14037.649058773612, 14439.278036098258, 1726.6719323328527, 1728.3086765293983, 1753.2198171813548, 1774.325756212631, 1801.2794882047156, 64117.67941160311, 71254.0, 71569.64215178943, 72170.0, 72284.63857680731, 10236.283460157718, 10451.94774026125, 10457.267991240693, 10545.894541054644, 10664.41345725977, 14777.113373197642, 14844.92577537127, 14856.0, 14901.70196596062, 14923.70152596942, 6587.9670601646685, 6831.658417079127, 6879.245792322926, 7010.824729381704, 7065.4700897432895, 6221.3156552779155, 6269.529785266123, 6368.267649220306, 6396.61620302774, 6455.4835613150835, 6498.870022599522, 6595.571287866273, 6719.361660642231, 6751.156105486814, 6960.9303906961295, 1752.7195648696147, 1785.669651114548, 1803.323753592403, 1819.1359104425292, 1850.9259629614935, 935.5415846235296, 945.7493764152505, 948.9762755931157, 964.864918911353, 971.6550624528332, 16817.0, 17290.827091729174, 17890.463286101436, 18104.36634717805, 18593.628127437376, 925.8472352061834, 928.7724507495707, 939.262678797141, 943.1228957069991, 955.7085089047907, 9536.523173841419, 10182.439965801952, 10261.230407719451, 10263.7434064149, 10360.430176340373, 424201.0, 478698.0, 478792.0, 500859.0, 501124.0, 75395.0, 76132.0, 76461.0, 80169.0, 80814.0, 896.5651658945407, 906.4289497616592, 923.2567782934668, 925.421611492817, 960.3469640644429, 15268.770968435705, 16393.19682331819, 16413.83586164123, 16802.66394672124, 16828.326866925676, 40123.398149027205, 40137.39793903152, 40851.591484084776, 40876.59123408728, 40995.1800963985, 53384.466155339505, 54293.61219276974, 54818.0, 55976.720116399156, 56235.437645624654, 7942.880856787037, 7980.8004799878145, 7981.403719256288, 8168.877466838121, 8568.828623427371, 11822.34977076269, 11960.222585531912, 12951.5466958656, 12965.611031669065, 12992.935035324763, 10109.797804044025, 10118.696439106838, 10592.570003049797, 10744.409057501913, 11098.667039988813, 10719.785604287714, 10772.838407423738, 10825.945870270598, 11028.0, 11239.0, 10264.553434999876, 10646.84029739539, 10888.237823352289, 10890.94554527254, 11121.443927803739, 6877.828054298682, 7294.598797066213, 7339.229380914927, 7972.123066462568, 8288.958555207186, 10487.0, 10989.780204395707, 11010.3944283062, 11392.658220253406, 11413.201075924606], "value": 8654.846367588501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.9598612041636, 1350.864913508649, 1351.1690310459064, 1354.2551596621859, 1363.5227670315385, 7235.167955685098, 7487.43844211685, 7605.505642133257, 7650.885236721447, 7651.464397492177, 7723.304902558769, 7836.804079897991, 7843.0, 7850.254225848549, 7886.77754947984, 2137.316058861165, 2168.078566609193, 2179.3135162423864, 2180.9345719628436, 2187.2016713899393, 2095.5808838232338, 2137.957240855182, 2145.0990583954776, 2158.5359147783224, 2163.7836216378396, 2110.905009274579, 2121.9787802122014, 2149.5271040371094, 2154.493693981921, 2157.590057888996, 2106.3259756877806, 2122.745270567542, 2130.6697461893355, 2130.7975742304457, 2131.6163090643677, 1838.3657638114828, 1882.3223639489772, 2007.5583371658213, 2042.9795702042939, 2157.8597391169524, 7747.806304842367, 7750.612469376565, 7782.299593036654, 7785.961070194669, 7790.649420776079, 4625.907481850344, 4758.214894542396, 4759.666823322369, 4762.618990480788, 4763.571278584909, 2923.269182704324, 2941.4999450093537, 2958.2604348912773, 2981.5825784390204, 3006.4588374092873, 1052.2108418685987, 1078.1051727066515, 1078.9298695584841, 1092.7104317355906, 1123.584273818684, 10124.54439550222, 10134.31440668216, 10167.288289819715, 10209.336393134348, 10215.336003159771, 3812.7140464465274, 3998.520177578651, 4033.4554835096887, 4146.937795933063, 4147.854825081107, 8108.986376702912, 8128.634211460499, 8135.0, 8143.633536490754, 8163.020437547413, 4493.146302202571, 4497.977510112429, 4516.977415112903, 4596.816127354935, 4615.053913947632, 4178.456800615901, 4224.809883555247, 4228.175505776406, 4304.569543045671, 4316.503602085801, 3258.7393008559256, 3300.3234336960863, 3379.4086034943784, 3414.197663549064, 3422.058933793227, 1014.5802261606123, 1035.761774791802, 1037.071820720451, 1037.123630532199, 1043.9217058720626, 747.4767662636176, 770.7302444144617, 778.4900889917113, 780.968761249555, 783.3615603283306, 4840.903181936412, 4856.0, 4911.484294149063, 5025.924611130836, 5091.159958606862, 545.5281181777734, 547.5373309553421, 548.4542879834511, 550.6530885542082, 553.8643032457073, 3111.8755249789756, 3122.9531557026207, 3134.717875391226, 3142.277276226435, 3242.2542815152647, 8243.670253189804, 8618.267447267053, 8771.64039573867, 8876.245519130816, 9017.864732029026, 9259.212966897754, 9304.0, 9312.301577381724, 9314.953425232967, 9325.067493250757, 6645.401913827779, 6822.215445223764, 6844.623545705034, 7028.6485675714985, 7033.120859892513, 5098.1842905135, 5233.6074794389815, 5332.520073193431, 5408.513233808976, 5453.236546883519, 8440.746777596436, 8462.576871156542, 8508.319334453352, 8604.78488037779, 8625.353098517762, 8129.268365847102, 8485.321174305916, 8495.915040849759, 8672.349573781865, 8685.6091475885, 6632.1709786276715, 6722.428593569602, 6743.9325606743305, 6773.18721753373, 6774.491913106438, 7250.9637451812405, 7292.525985810906, 7323.231060738546, 7327.560346379234, 7346.33882950537, 6627.4698024158915, 6737.966310168614, 6744.055832183596, 6749.0888730020815, 6774.966125169342, 6581.3418658133805, 6600.9339906602245, 6628.900566491603, 6667.733290668319, 6677.599344039373, 5797.652140871562, 5816.912746308724, 5889.764409423575, 5951.613145145551, 5970.194023806731, 4223.303154979394, 4251.0, 4302.978485107555, 4343.239933011773, 4411.713238639478, 4344.869653910388, 4346.978265108654, 4353.73877567347, 4418.160549495586, 4558.179527685049], "value": 3952.1482829938686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.77879714576966, 357.99105022374437, 360.9910300709518, 362.856671614712, 367.2819637608476, 4955.975220123899, 4999.9250011249815, 5012.396033269355, 5020.9497905020935, 5022.899542009158, 4936.580390666798, 4980.427250866152, 4983.601311895049, 5000.7249601271915, 5007.599392048636, 3929.174873276608, 3964.801759912007, 3991.521017477892, 4023.155137421145, 4026.11425486394, 3902.2585708715396, 3965.3655415133585, 3998.1603863188766, 4003.11931375097, 4043.2722110020186, 3930.0, 3953.308171070066, 3958.34687276599, 3999.2601368746728, 4018.156187200677, 3808.8857334280015, 3943.38877473992, 3986.740861843971, 3999.340108882031, 3999.6000399959917, 3569.250457403948, 3592.191756854713, 3598.874039408608, 3603.171510364378, 3610.1696609779897, 4888.266759985995, 4902.583280421169, 4905.141600219948, 4913.189323761575, 4920.5571498565305, 4596.563326483979, 4601.194790911577, 4616.515265897099, 4657.184992626277, 4658.440987081538, 4929.704217746947, 5200.179937022012, 5207.869803254911, 5211.400688920785, 5212.244224587452, 3748.3440397930526, 3753.981230093832, 3755.8122093895195, 3777.6788972937334, 3780.073881898925, 5219.947800522022, 5511.0, 5512.531434828044, 5540.695261760601, 5554.555635549146, 3466.890595009623, 3744.4008958566496, 3760.360738674432, 3764.0778009387877, 3766.5103536540073, 3834.8082595870096, 3860.4209368594934, 3867.6712479439, 3871.690264778811, 3874.2057878134915, 4417.690761646718, 4438.7114837535455, 4440.289553671461, 4442.355858400514, 4467.285234362486, 5098.745062746848, 5221.903400285906, 5230.607704422184, 5274.0, 5333.466653334713, 1288.5168061976758, 1295.740851829638, 1299.4477347127433, 1303.2766814417898, 1311.698309388846, 863.6631713631689, 889.4485419040108, 896.6189369517929, 906.4289497616592, 913.8720579118929, 4393.538678438782, 4394.450693663292, 4397.2304846651705, 4418.160549495586, 4447.799849006802, 5186.92219616706, 5256.789728410898, 5270.868228294324, 5272.077386457355, 5273.630845840754, 4210.368444733314, 4339.327404252346, 4365.541618130051, 4366.825326986948, 4422.8721675973065, 2732.9775965785175, 2737.3293543082073, 2741.575055866344, 2743.6981931987866, 2753.1553858914576, 4830.975845120752, 4846.546036189129, 4862.027594481118, 4866.562009419169, 4896.926546101811, 5113.411957624847, 5306.363236411578, 5309.8938021239355, 5313.654612450178, 5343.332083489564, 4776.140294746979, 4833.4441539222735, 4838.540338667821, 4847.418309802846, 4858.975705121452, 5193.792248310026, 5195.765820697136, 5201.505856943584, 5216.713080780593, 5237.502437268454, 4987.650864439454, 5001.899962000813, 5043.394792624908, 5168.147255702767, 5176.498815343659, 4813.7593120344545, 4872.366592342973, 4897.0, 4905.541593176873, 5017.297578338962, 3806.8096595169577, 3840.7887566184127, 3858.9035274118373, 3861.436118372064, 3869.671077958405, 5368.792021795065, 5378.784848606012, 5385.0, 5394.2448057272795, 5417.756200971045, 4816.20532612115, 5017.774200160929, 5137.845864624067, 5148.794048238178, 5170.612204084633, 5060.291559181644, 5075.771590278372, 5081.002208696887, 5114.974425127999, 5126.538611524831, 5085.542301192911, 5106.821261255838, 5110.284560161655, 5130.384353877409, 5133.4096578893905, 4987.279388610923, 5205.8177963772605, 5220.295260139985, 5221.877296381296, 5226.425093239816, 5084.491550844886, 5095.490450955023, 5096.904165604413, 5120.155174396183, 5134.71632091977], "value": 3925.2164830809143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.1443858010973, 652.2433976587157, 722.036081830756, 738.2248638929123, 750.5946788734084, 11545.711357216074, 12490.937545312261, 12542.059345549085, 12574.685632859184, 12587.937060314709, 12128.332941688204, 12263.386830658475, 12270.938645306762, 12274.20217685852, 12309.446074926627, 764.7782143178486, 768.1051574915217, 794.7019867549669, 797.099277816067, 802.4142376065475, 785.3834739729314, 786.9960650196741, 788.2275370137269, 788.846174995876, 791.2008871040262, 812.1350761439078, 813.093400858042, 813.9511629302232, 816.0819078536646, 820.0651257566379, 809.8420807942483, 812.475953010305, 814.5927036481759, 814.9103598604149, 816.7141500474816, 589.858433975847, 593.9465448109647, 594.4679511836882, 594.7412875399172, 595.1073389915127, 12878.29169395683, 12913.418896149697, 13155.342232888317, 13164.6708832279, 13200.273984930825, 11332.773344533145, 12026.15816892818, 12219.389030548436, 12379.75240495194, 12478.0, 10051.655306476534, 10066.547005384775, 10183.490825458697, 10210.387376757344, 10256.0, 3106.9067927962196, 3122.6408962969094, 3141.3301662707795, 3154.4164329598866, 3176.237702951275, 60375.09437358487, 60537.6973115136, 61638.38361616416, 62178.68910655463, 62860.0, 9288.442693438416, 9366.859497107549, 9544.904550954401, 9629.32594718377, 9654.903450965401, 17091.316347346215, 17926.462206133838, 17975.640487190445, 18747.0, 18959.0, 6351.714172862232, 6353.269374022047, 6421.101045853584, 6425.839354016093, 6482.805515834532, 3533.116720819795, 3556.110972256936, 3578.874739384109, 3593.640635936438, 3637.672609465161, 3034.1656044587917, 3117.173948903542, 3117.7817552771544, 3126.124685088179, 3143.701348371901, 548.9396166421691, 553.7425097329761, 557.8382269141904, 561.2479277767811, 574.2678085441096, 584.7164125399178, 609.689168288184, 624.1760875644197, 625.3152797686525, 627.9403456671608, 8047.114817370085, 8136.674533018613, 8191.8771218431775, 8339.24946754795, 8341.518100737116, 599.5802937943457, 611.1047315682457, 632.0834789555163, 637.5664548107331, 645.1033064040987, 4216.746995180299, 4389.779021978692, 4403.9779801100785, 4671.832041989503, 4741.880647758823, 66056.0, 66664.33335666679, 67686.66156669185, 67860.6606966962, 69358.0, 50046.0, 56632.433675662716, 57732.422675773545, 59393.0, 61658.69170654118, 50505.0, 50956.49043509518, 51575.484245157066, 51931.0, 52038.73980630073, 7590.658420370986, 7761.9611901940125, 7773.300402963534, 7781.688732450639, 7986.92013079885, 35417.0, 35451.645483545864, 36482.63517364793, 37017.444738328406, 37298.627013729514, 43202.0, 44095.77952110219, 46223.3066503996, 47139.76430117827, 47773.0, 10831.512581933674, 10845.403502807421, 11012.944935275273, 11019.118470522179, 11195.60815371458, 12476.18904771187, 12536.498540058661, 12572.559960401342, 12765.297908614744, 12934.870651293366, 10103.54534045955, 10234.437105958947, 10307.742306442398, 10334.741631459274, 10688.893111069101, 10998.175136864607, 11438.714032149262, 11869.703257418634, 12009.459574319002, 12370.0, 11281.266717663326, 11500.712482188012, 11619.88380116222, 11663.183577149519, 12145.878541214828, 8519.275861551838, 8990.955045224993, 9009.774755631162, 9278.164965153168, 9732.221422286058, 8854.776892983971, 9001.459912405015, 9826.361286516354, 9903.29165983689, 9939.155171810187], "value": 6202.503726865278, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 114.0, 115.0, 117.0, 117.0, 114.0, 115.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 126.0, 171.0, 127.0, 126.0, 126.0, 133.0, 157.0, 127.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 167.0, 167.0, 170.0, 162.0, 162.0, 170.0, 163.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 109.0, 77.0, 78.0, 76.0, 77.0, 96.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 107.0, 84.0, 85.0, 85.0, 99.0, 84.0, 87.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 151.0, 150.0, 150.0, 151.0, 150.0, 151.0, 149.0, 152.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 68.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 92.0, 84.0, 85.0, 89.0, 84.0, 87.0, 91.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 151.0, 129.0, 151.0, 141.0, 139.0, 134.0, 134.0, 216.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 183.0, 175.0, 181.0, 172.0, 178.0, 175.0, 186.0, 182.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 67.0, 67.0, 70.0, 67.0, 66.0, 67.0, 66.0], "value": 68.0, "unit": "score"}]}]} 17:25:35 INFO - Return code: 0 17:25:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:25:35 ERROR - # TBPL SUCCESS # 17:25:35 INFO - Running post-action listener: _resource_record_post_action 17:25:35 INFO - [mozharness: 2017-02-05 01:25:35.877201Z] Finished run-tests step (success) 17:25:35 INFO - Running post-run listener: _resource_record_post_run 17:25:35 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 339968; Write bytes: 395644928; Read time: 136; Write time: 429532 17:25:35 INFO - TinderboxPrint: CPU usage
13.5% 17:25:35 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 136 17:25:35 INFO - TinderboxPrint: I/O write bytes / time
395,644,928 / 429,532 17:25:35 INFO - TinderboxPrint: CPU idle
8,313.0 (86.5%) 17:25:35 INFO - TinderboxPrint: CPU user
1,235.1 (12.9%) 17:25:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:25:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100220928; Read time: 0; Write time: 225492 17:25:35 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 339968; Write bytes: 295424000; Read time: 136; Write time: 204040 17:25:36 INFO - Running post-run listener: _upload_blobber_files 17:25:36 INFO - Blob upload gear active. 17:25:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:25:36 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 17:25:36 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:25:36 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:25:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:37 INFO - (blobuploader) - INFO - Done attempting. 17:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:38 INFO - (blobuploader) - INFO - Done attempting. 17:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:39 INFO - (blobuploader) - INFO - Done attempting. 17:25:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:25:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:42 INFO - (blobuploader) - INFO - Done attempting. 17:25:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:42 INFO - Return code: 0 17:25:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:25:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1881465906fdebdd031613bfd1a07f5ba9a49f286d449323c541ff0af73772eb5e999ef095bdadf27fcb9877f5b61e36c51395852685c7dbe813ed66158383ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b2adf04642eed21f084b9698443c1a70dafb68f96f7f063a31fcc7875964999283bc4dc768d71b683627d198ec07259e1279e05edd05de63ceda26f6f153c5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a484801068f8f96ef10d2f057eb2b1e98dd3f2e816a4a40159c10163ab3618eca87ef10730fadf504359ac9a86b5ae5f0c39ee7c17789af72ec0cb67cf5dbc51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78ac3ac144032891834577b10a4733f4049f096614f972bb97ee2068d4a400dba39df0ce7abae3daa7d182dbb66db0925da0247da6268cdc785d3ff99735b7d3"} 17:25:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:25:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:25:42 INFO - Contents: 17:25:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1881465906fdebdd031613bfd1a07f5ba9a49f286d449323c541ff0af73772eb5e999ef095bdadf27fcb9877f5b61e36c51395852685c7dbe813ed66158383ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b2adf04642eed21f084b9698443c1a70dafb68f96f7f063a31fcc7875964999283bc4dc768d71b683627d198ec07259e1279e05edd05de63ceda26f6f153c5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a484801068f8f96ef10d2f057eb2b1e98dd3f2e816a4a40159c10163ab3618eca87ef10730fadf504359ac9a86b5ae5f0c39ee7c17789af72ec0cb67cf5dbc51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78ac3ac144032891834577b10a4733f4049f096614f972bb97ee2068d4a400dba39df0ce7abae3daa7d182dbb66db0925da0247da6268cdc785d3ff99735b7d3"} 17:25:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:25:42 INFO - Copying logs to upload dir... 17:25:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:25:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.246265 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-02-04 17:25:42.788542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 17:25:42.796404) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1881465906fdebdd031613bfd1a07f5ba9a49f286d449323c541ff0af73772eb5e999ef095bdadf27fcb9877f5b61e36c51395852685c7dbe813ed66158383ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b2adf04642eed21f084b9698443c1a70dafb68f96f7f063a31fcc7875964999283bc4dc768d71b683627d198ec07259e1279e05edd05de63ceda26f6f153c5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a484801068f8f96ef10d2f057eb2b1e98dd3f2e816a4a40159c10163ab3618eca87ef10730fadf504359ac9a86b5ae5f0c39ee7c17789af72ec0cb67cf5dbc51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78ac3ac144032891834577b10a4733f4049f096614f972bb97ee2068d4a400dba39df0ce7abae3daa7d182dbb66db0925da0247da6268cdc785d3ff99735b7d3"} build_url:https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/S0WmBJt4SWyTK4qG7sUsJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1881465906fdebdd031613bfd1a07f5ba9a49f286d449323c541ff0af73772eb5e999ef095bdadf27fcb9877f5b61e36c51395852685c7dbe813ed66158383ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b2adf04642eed21f084b9698443c1a70dafb68f96f7f063a31fcc7875964999283bc4dc768d71b683627d198ec07259e1279e05edd05de63ceda26f6f153c5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a484801068f8f96ef10d2f057eb2b1e98dd3f2e816a4a40159c10163ab3618eca87ef10730fadf504359ac9a86b5ae5f0c39ee7c17789af72ec0cb67cf5dbc51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78ac3ac144032891834577b10a4733f4049f096614f972bb97ee2068d4a400dba39df0ce7abae3daa7d182dbb66db0925da0247da6268cdc785d3ff99735b7d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 17:25:42.828987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:25:42.829518) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486256504.308716-596658861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:25:42.911880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 17:25:42.912424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 17:25:42.912964) ========= ========= Total master_lag: 0.20 =========